builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1481826844.6 results: success (0) buildid: 20161215085501 builduid: 2fac92de9cb2479eab5a0a8b6ea37a67 revision: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.599283) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.599658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.599952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.614407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.614671) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 10:34:04-- 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% 46.4M=0s 2016-12-15 10:34:04 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098649 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.726406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.726684) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014200 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.778606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:04.778916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 --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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 10:34:05,031 truncating revision to first 12 chars 2016-12-15 10:34:05,032 Setting DEBUG logging. 2016-12-15 10:34:05,032 attempt 1/10 2016-12-15 10:34:05,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ae5275b8c53b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 10:34:05,338 unpacking tar archive at: mozilla-beta-ae5275b8c53b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:05.438354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:05.438979) ========= script_repo_revision: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:05.439753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:05.440418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 10:34:05.450992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-12-15 10:34:05.451280) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:34:05 INFO - MultiFileLogger online at 20161215 10:34:05 in /builds/slave/test 10:34:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:05 INFO - {'append_to_log': False, 10:34:05 INFO - 'base_work_dir': '/builds/slave/test', 10:34:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:05 INFO - 'branch': 'Mozilla-Beta', 10:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:05 INFO - 'config_files': ('talos/linux_config.py',), 10:34:05 INFO - 'default_actions': ('clobber', 10:34:05 INFO - 'read-buildbot-config', 10:34:05 INFO - 'download-and-extract', 10:34:05 INFO - 'populate-webroot', 10:34:05 INFO - 'create-virtualenv', 10:34:05 INFO - 'install', 10:34:05 INFO - 'run-tests'), 10:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:05 INFO - 'download_minidump_stackwalk': True, 10:34:05 INFO - 'download_symbols': 'ondemand', 10:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:05 INFO - 'installer_path': 'installer.exe', 10:34:05 INFO - 'log_level': 'info', 10:34:05 INFO - 'log_name': 'talos', 10:34:05 INFO - 'log_to_console': True, 10:34:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:34:05 INFO - 'opt_config_files': (), 10:34:05 INFO - 'pip_index': False, 10:34:05 INFO - 'sps_profile': False, 10:34:05 INFO - 'sps_profile_interval': 0, 10:34:05 INFO - 'suite': 'dromaeojs', 10:34:05 INFO - 'system_bits': '32', 10:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:05 INFO - 'title': 'talos-linux64-ix-067', 10:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:05 INFO - 'use_talos_json': True, 10:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:05 INFO - 'work_dir': 'build'} 10:34:05 INFO - [mozharness: 2016-12-15 18:34:05.802177Z] Running clobber step. 10:34:05 INFO - Running pre-action listener: _resource_record_pre_action 10:34:05 INFO - Running main action method: clobber 10:34:05 INFO - rmtree: /builds/slave/test/build 10:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:06 INFO - Running post-action listener: _resource_record_post_action 10:34:06 INFO - [mozharness: 2016-12-15 18:34:06.263436Z] Finished clobber step (success) 10:34:06 INFO - [mozharness: 2016-12-15 18:34:06.263537Z] Running read-buildbot-config step. 10:34:06 INFO - Running pre-action listener: _resource_record_pre_action 10:34:06 INFO - Running main action method: read_buildbot_config 10:34:06 INFO - Using buildbot properties: 10:34:06 INFO - { 10:34:06 INFO - "project": "", 10:34:06 INFO - "product": "firefox", 10:34:06 INFO - "script_repo_revision": "production", 10:34:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:34:06 INFO - "repository": "", 10:34:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:34:06 INFO - "buildid": "20161215085501", 10:34:06 INFO - "pgo_build": "True", 10:34:06 INFO - "basedir": "/builds/slave/test", 10:34:06 INFO - "buildnumber": 26, 10:34:06 INFO - "slavename": "talos-linux64-ix-067", 10:34:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:34:06 INFO - "platform": "ubuntu64_hw", 10:34:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:34:06 INFO - "branch": "mozilla-beta", 10:34:06 INFO - "repo_path": "releases/mozilla-beta", 10:34:06 INFO - "revision": "ae5275b8c53ba76cb98576e4e2a3031b0d659ba3", 10:34:06 INFO - "stage_platform": "linux64-pgo", 10:34:06 INFO - "builduid": "2fac92de9cb2479eab5a0a8b6ea37a67", 10:34:06 INFO - "slavebuilddir": "test" 10:34:06 INFO - } 10:34:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 10:34:06 INFO - Running post-action listener: _resource_record_post_action 10:34:06 INFO - [mozharness: 2016-12-15 18:34:06.266004Z] Finished read-buildbot-config step (success) 10:34:06 INFO - [mozharness: 2016-12-15 18:34:06.266094Z] Running download-and-extract step. 10:34:06 INFO - Running pre-action listener: _resource_record_pre_action 10:34:06 INFO - Running main action method: download_and_extract 10:34:06 INFO - mkdir: /builds/slave/test/build/tests 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:06 INFO - trying https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:34:06 INFO - Downloaded 1327 bytes. 10:34:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 10:34:06 INFO - Using the following test package requirements: 10:34:06 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:34:06 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:34:06 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 10:34:06 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'jsshell-linux-x86_64.zip'], 10:34:06 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:34:06 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 10:34:06 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 10:34:06 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 10:34:06 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:34:06 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 10:34:06 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:34:06 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:34:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:34:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:34:07 INFO - Expected file size: 21962134 10:34:11 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:34:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 10:34:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:34:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 10:34:12 INFO - Expected file size: 21962134 10:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 10:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 10:34:17 INFO - Expected file size: 14414089 10:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:18 INFO - trying https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:34:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:34:19 INFO - Downloaded 56970671 bytes. 10:34:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:34:19 INFO - mkdir: /builds/slave/test/properties 10:34:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:19 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:19 INFO - Contents: 10:34:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 10:34:19 INFO - Running post-action listener: _resource_record_post_action 10:34:19 INFO - Running post-action listener: set_extra_try_arguments 10:34:19 INFO - [mozharness: 2016-12-15 18:34:19.948386Z] Finished download-and-extract step (success) 10:34:19 INFO - [mozharness: 2016-12-15 18:34:19.948733Z] Running populate-webroot step. 10:34:19 INFO - Running pre-action listener: _resource_record_pre_action 10:34:19 INFO - Running main action method: populate_webroot 10:34:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:19 INFO - '--tppagecycles', 10:34:19 INFO - '7'], 10:34:19 INFO - 'tests': ['tsvgm']}}, 10:34:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['damp', 'tps']}, 10:34:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'tests': ['damp', 'tps']}, 10:34:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['dromaeo_dom']}, 10:34:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['basic_compositor_video']}, 10:34:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:34:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['a11yr', 10:34:19 INFO - 'ts_paint', 10:34:19 INFO - 'tpaint', 10:34:19 INFO - 'sessionrestore', 10:34:19 INFO - 'sessionrestore_no_auto_restore', 10:34:19 INFO - 'tabpaint']}, 10:34:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['tsvgx', 10:34:19 INFO - 'tsvgr_opacity', 10:34:19 INFO - 'tart', 10:34:19 INFO - 'tscrollx', 10:34:19 INFO - 'cart']}, 10:34:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:19 INFO - 'tsvgr_opacity', 10:34:19 INFO - 'tart', 10:34:19 INFO - 'tscrollx', 10:34:19 INFO - 'cart']}, 10:34:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'talos_options': ['--disable-e10s'], 10:34:19 INFO - 'tests': ['tp5o']}, 10:34:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'tests': ['tp5o']}, 10:34:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'talos_options': ['--disable-e10s', 10:34:19 INFO - '--xperf_path', 10:34:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:19 INFO - 'tests': ['tp5n']}, 10:34:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:19 INFO - 'talos_options': ['--xperf_path', 10:34:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:19 INFO - 'tests': ['tp5n']}}, 10:34:19 INFO - 'talos.zip': {'path': '', 10:34:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:19 INFO - Running post-action listener: _resource_record_post_action 10:34:19 INFO - [mozharness: 2016-12-15 18:34:19.970999Z] Finished populate-webroot step (success) 10:34:19 INFO - [mozharness: 2016-12-15 18:34:19.971098Z] Running create-virtualenv step. 10:34:19 INFO - Running pre-action listener: _resource_record_pre_action 10:34:19 INFO - Running main action method: create_virtualenv 10:34:19 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:19 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 10:34:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:20 INFO - Using real prefix '/usr' 10:34:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:20 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:22 INFO - Installing pip.................done. 10:34:22 INFO - Return code: 0 10:34:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:22 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:22 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 10:34:22 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 10:34:22 INFO - Using env: {'DISPLAY': ':0', 10:34:22 INFO - 'HOME': '/home/cltbld', 10:34:22 INFO - 'LANG': 'en_US.UTF-8', 10:34:22 INFO - 'LANGUAGE': 'en_US:en', 10:34:22 INFO - 'LOGNAME': 'cltbld', 10:34:22 INFO - 'MAIL': '/var/mail/cltbld', 10:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:22 INFO - 'MOZ_NO_REMOTE': '1', 10:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:22 INFO - 'NO_EM_RESTART': '1', 10:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:22 INFO - 'PWD': '/builds/slave/test', 10:34:22 INFO - 'SHELL': '/bin/bash', 10:34:22 INFO - 'SHLVL': '1', 10:34:22 INFO - 'TERM': 'linux', 10:34:22 INFO - 'TMOUT': '86400', 10:34:22 INFO - 'USER': 'cltbld', 10:34:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:22 INFO - '_': '/tools/buildbot/bin/python'} 10:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:22 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 10:34:22 INFO - Cleaning up... 10:34:22 INFO - Return code: 0 10:34:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:22 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:22 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 10:34:22 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 10:34:22 INFO - Using env: {'DISPLAY': ':0', 10:34:22 INFO - 'HOME': '/home/cltbld', 10:34:22 INFO - 'LANG': 'en_US.UTF-8', 10:34:22 INFO - 'LANGUAGE': 'en_US:en', 10:34:22 INFO - 'LOGNAME': 'cltbld', 10:34:22 INFO - 'MAIL': '/var/mail/cltbld', 10:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:22 INFO - 'MOZ_NO_REMOTE': '1', 10:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:22 INFO - 'NO_EM_RESTART': '1', 10:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:22 INFO - 'PWD': '/builds/slave/test', 10:34:22 INFO - 'SHELL': '/bin/bash', 10:34:22 INFO - 'SHLVL': '1', 10:34:22 INFO - 'TERM': 'linux', 10:34:22 INFO - 'TMOUT': '86400', 10:34:22 INFO - 'USER': 'cltbld', 10:34:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:22 INFO - '_': '/tools/buildbot/bin/python'} 10:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:22 INFO - Downloading/unpacking psutil>=3.1.1 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:25 INFO - Installing collected packages: psutil 10:34:25 INFO - Running setup.py install for psutil 10:34:25 INFO - building 'psutil._psutil_linux' extension 10:34:25 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 10:34:25 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 10:34:25 INFO - building 'psutil._psutil_posix' extension 10:34:25 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 10:34:25 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 10:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:25 INFO - Successfully installed psutil 10:34:25 INFO - Cleaning up... 10:34:25 INFO - Return code: 0 10:34:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:25 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')]} 10:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:25 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')]} 10:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:25 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:25 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 10:34:25 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 10:34:25 INFO - Using env: {'DISPLAY': ':0', 10:34:25 INFO - 'HOME': '/home/cltbld', 10:34:25 INFO - 'LANG': 'en_US.UTF-8', 10:34:25 INFO - 'LANGUAGE': 'en_US:en', 10:34:25 INFO - 'LOGNAME': 'cltbld', 10:34:25 INFO - 'MAIL': '/var/mail/cltbld', 10:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:25 INFO - 'MOZ_NO_REMOTE': '1', 10:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:25 INFO - 'NO_EM_RESTART': '1', 10:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:25 INFO - 'PWD': '/builds/slave/test', 10:34:25 INFO - 'SHELL': '/bin/bash', 10:34:25 INFO - 'SHLVL': '1', 10:34:25 INFO - 'TERM': 'linux', 10:34:25 INFO - 'TMOUT': '86400', 10:34:25 INFO - 'USER': 'cltbld', 10:34:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:25 INFO - '_': '/tools/buildbot/bin/python'} 10:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:25 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 10:34:25 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 10:34:25 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 10:34:25 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 10:34:25 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 10:34:25 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 10:34:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:27 INFO - Installing collected packages: mozsystemmonitor 10:34:27 INFO - Running setup.py install for mozsystemmonitor 10:34:27 INFO - Successfully installed mozsystemmonitor 10:34:27 INFO - Cleaning up... 10:34:28 INFO - Return code: 0 10:34:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34:28 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')]} 10:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:28 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')]} 10:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:28 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:28 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 10:34:28 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 10:34:28 INFO - Using env: {'DISPLAY': ':0', 10:34:28 INFO - 'HOME': '/home/cltbld', 10:34:28 INFO - 'LANG': 'en_US.UTF-8', 10:34:28 INFO - 'LANGUAGE': 'en_US:en', 10:34:28 INFO - 'LOGNAME': 'cltbld', 10:34:28 INFO - 'MAIL': '/var/mail/cltbld', 10:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:28 INFO - 'MOZ_NO_REMOTE': '1', 10:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:28 INFO - 'NO_EM_RESTART': '1', 10:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:28 INFO - 'PWD': '/builds/slave/test', 10:34:28 INFO - 'SHELL': '/bin/bash', 10:34:28 INFO - 'SHLVL': '1', 10:34:28 INFO - 'TERM': 'linux', 10:34:28 INFO - 'TMOUT': '86400', 10:34:28 INFO - 'USER': 'cltbld', 10:34:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:28 INFO - '_': '/tools/buildbot/bin/python'} 10:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:28 INFO - Downloading/unpacking jsonschema==2.5.1 10:34:28 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 10:34:28 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 10:34:28 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 10:34:28 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 10:34:28 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 10:34:28 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 10:34:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:30 INFO - warning: no files found matching '*.txt' 10:34:30 INFO - no previously-included directories found matching 'build' 10:34:30 INFO - no previously-included directories found matching 'dist' 10:34:30 INFO - no previously-included directories found matching '.git*' 10:34:30 INFO - Installing collected packages: jsonschema, functools32 10:34:30 INFO - Running setup.py install for functools32 10:34:30 INFO - warning: no files found matching '*.txt' 10:34:30 INFO - no previously-included directories found matching 'build' 10:34:30 INFO - no previously-included directories found matching 'dist' 10:34:30 INFO - no previously-included directories found matching '.git*' 10:34:30 INFO - Successfully installed jsonschema functools32 10:34:30 INFO - Cleaning up... 10:34:30 INFO - Return code: 0 10:34:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:34:30 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')]} 10:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:30 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')]} 10:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:30 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:30 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 10:34:30 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 10:34:30 INFO - Using env: {'DISPLAY': ':0', 10:34:30 INFO - 'HOME': '/home/cltbld', 10:34:30 INFO - 'LANG': 'en_US.UTF-8', 10:34:30 INFO - 'LANGUAGE': 'en_US:en', 10:34:30 INFO - 'LOGNAME': 'cltbld', 10:34:30 INFO - 'MAIL': '/var/mail/cltbld', 10:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:30 INFO - 'MOZ_NO_REMOTE': '1', 10:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:30 INFO - 'NO_EM_RESTART': '1', 10:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:30 INFO - 'PWD': '/builds/slave/test', 10:34:30 INFO - 'SHELL': '/bin/bash', 10:34:30 INFO - 'SHLVL': '1', 10:34:30 INFO - 'TERM': 'linux', 10:34:30 INFO - 'TMOUT': '86400', 10:34:30 INFO - 'USER': 'cltbld', 10:34:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:30 INFO - '_': '/tools/buildbot/bin/python'} 10:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:34:30 INFO - Cleaning up... 10:34:30 INFO - Return code: 0 10:34:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:30 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')]} 10:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:30 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')]} 10:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:30 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:30 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 10:34:30 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 10:34:30 INFO - Using env: {'DISPLAY': ':0', 10:34:30 INFO - 'HOME': '/home/cltbld', 10:34:30 INFO - 'LANG': 'en_US.UTF-8', 10:34:30 INFO - 'LANGUAGE': 'en_US:en', 10:34:30 INFO - 'LOGNAME': 'cltbld', 10:34:30 INFO - 'MAIL': '/var/mail/cltbld', 10:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:30 INFO - 'MOZ_NO_REMOTE': '1', 10:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:30 INFO - 'NO_EM_RESTART': '1', 10:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:30 INFO - 'PWD': '/builds/slave/test', 10:34:30 INFO - 'SHELL': '/bin/bash', 10:34:30 INFO - 'SHLVL': '1', 10:34:30 INFO - 'TERM': 'linux', 10:34:30 INFO - 'TMOUT': '86400', 10:34:30 INFO - 'USER': 'cltbld', 10:34:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:30 INFO - '_': '/tools/buildbot/bin/python'} 10:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:31 INFO - Downloading/unpacking blobuploader==1.2.4 10:34:31 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 10:34:31 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 10:34:31 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 10:34:31 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 10:34:31 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 10:34:31 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 10:34:33 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 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 10:34:33 INFO - Downloading docopt-0.6.1.tar.gz 10:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:33 INFO - Running setup.py install for blobuploader 10:34:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:33 INFO - Running setup.py install for requests 10:34:34 INFO - Running setup.py install for docopt 10:34:34 INFO - Successfully installed blobuploader requests docopt 10:34:34 INFO - Cleaning up... 10:34:34 INFO - Return code: 0 10:34:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:34 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:34 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 10:34:34 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 10:34:34 INFO - Using env: {'DISPLAY': ':0', 10:34:34 INFO - 'HOME': '/home/cltbld', 10:34:34 INFO - 'LANG': 'en_US.UTF-8', 10:34:34 INFO - 'LANGUAGE': 'en_US:en', 10:34:34 INFO - 'LOGNAME': 'cltbld', 10:34:34 INFO - 'MAIL': '/var/mail/cltbld', 10:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:34 INFO - 'MOZ_NO_REMOTE': '1', 10:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:34 INFO - 'NO_EM_RESTART': '1', 10:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:34 INFO - 'PWD': '/builds/slave/test', 10:34:34 INFO - 'SHELL': '/bin/bash', 10:34:34 INFO - 'SHLVL': '1', 10:34:34 INFO - 'TERM': 'linux', 10:34:34 INFO - 'TMOUT': '86400', 10:34:34 INFO - 'USER': 'cltbld', 10:34:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:34 INFO - '_': '/tools/buildbot/bin/python'} 10:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:34 INFO - Running setup.py (path:/tmp/pip-UdLUxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:34 INFO - Running setup.py (path:/tmp/pip-E01x99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:34 INFO - Running setup.py (path:/tmp/pip-gzoJXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:34 INFO - Running setup.py (path:/tmp/pip-fYZnGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:34 INFO - Running setup.py (path:/tmp/pip-IEg2vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:35 INFO - Running setup.py (path:/tmp/pip-soJMub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:35 INFO - Running setup.py (path:/tmp/pip-Cj2KoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:35 INFO - Running setup.py (path:/tmp/pip-VP6eWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:35 INFO - Running setup.py (path:/tmp/pip-e_I_Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:35 INFO - Running setup.py (path:/tmp/pip-UOTBsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:35 INFO - Running setup.py (path:/tmp/pip-2FuFTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:35 INFO - Running setup.py (path:/tmp/pip-FPtbqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:35 INFO - Running setup.py (path:/tmp/pip-XDBUpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:35 INFO - Running setup.py (path:/tmp/pip-ChJhHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:35 INFO - Running setup.py (path:/tmp/pip-PUYZZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:35 INFO - Running setup.py (path:/tmp/pip-nwZKCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:35 INFO - Running setup.py (path:/tmp/pip-jaWq0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:35 INFO - Running setup.py install for manifestparser 10:34:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for mozcrash 10:34:36 INFO - Running setup.py install for mozdebug 10:34:36 INFO - Running setup.py install for mozdevice 10:34:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for mozfile 10:34:36 INFO - Running setup.py install for mozhttpd 10:34:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for mozinfo 10:34:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for mozInstall 10:34:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for mozleak 10:34:36 INFO - Running setup.py install for mozlog 10:34:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:36 INFO - Running setup.py install for moznetwork 10:34:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozprocess 10:34:37 INFO - Running setup.py install for mozprofile 10:34:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozrunner 10:34:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Running setup.py install for mozscreenshot 10:34:37 INFO - Running setup.py install for moztest 10:34:37 INFO - Running setup.py install for mozversion 10:34:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:37 INFO - Cleaning up... 10:34:37 INFO - Return code: 0 10:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:37 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:37 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 10:34:37 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 10:34:37 INFO - Using env: {'DISPLAY': ':0', 10:34:37 INFO - 'HOME': '/home/cltbld', 10:34:37 INFO - 'LANG': 'en_US.UTF-8', 10:34:37 INFO - 'LANGUAGE': 'en_US:en', 10:34:37 INFO - 'LOGNAME': 'cltbld', 10:34:37 INFO - 'MAIL': '/var/mail/cltbld', 10:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:37 INFO - 'MOZ_NO_REMOTE': '1', 10:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:37 INFO - 'NO_EM_RESTART': '1', 10:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:37 INFO - 'PWD': '/builds/slave/test', 10:34:37 INFO - 'SHELL': '/bin/bash', 10:34:37 INFO - 'SHLVL': '1', 10:34:37 INFO - 'TERM': 'linux', 10:34:37 INFO - 'TMOUT': '86400', 10:34:37 INFO - 'USER': 'cltbld', 10:34:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:37 INFO - '_': '/tools/buildbot/bin/python'} 10:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:37 INFO - Running setup.py (path:/tmp/pip-nI3foF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:38 INFO - Running setup.py (path:/tmp/pip-BAOBEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:38 INFO - Running setup.py (path:/tmp/pip-adJV2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:38 INFO - Running setup.py (path:/tmp/pip-GixsI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:38 INFO - Running setup.py (path:/tmp/pip-Ut3Jfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:38 INFO - Running setup.py (path:/tmp/pip-pebcSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:38 INFO - Running setup.py (path:/tmp/pip-C7GQxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:38 INFO - Running setup.py (path:/tmp/pip-SItLHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:38 INFO - Running setup.py (path:/tmp/pip-ijk2gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:38 INFO - Running setup.py (path:/tmp/pip-ZgPG1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:38 INFO - Running setup.py (path:/tmp/pip-DQ2uGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:38 INFO - Running setup.py (path:/tmp/pip-_8CYLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:38 INFO - Running setup.py (path:/tmp/pip-fielXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:38 INFO - Running setup.py (path:/tmp/pip-nxNyNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:38 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)) 10:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:38 INFO - Running setup.py (path:/tmp/pip-AKla7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:39 INFO - Running setup.py (path:/tmp/pip-nSj8uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:39 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)) 10:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:39 INFO - Running setup.py (path:/tmp/pip-QRXk98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:39 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)) 10:34:39 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)) 10:34:39 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)) 10:34:39 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)) 10:34:39 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)) 10:34:39 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)) 10:34:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:41 INFO - Downloading blessings-1.6.tar.gz 10:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:34:41 INFO - Installing collected packages: blessings 10:34:41 INFO - Running setup.py install for blessings 10:34:41 INFO - Successfully installed blessings 10:34:41 INFO - Cleaning up... 10:34:41 INFO - Return code: 0 10:34:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:41 INFO - Reading from file tmpfile_stdout 10:34:41 INFO - Current package versions: 10:34:41 INFO - argparse == 1.2.1 10:34:41 INFO - blessings == 1.6 10:34:41 INFO - blobuploader == 1.2.4 10:34:41 INFO - docopt == 0.6.1 10:34:41 INFO - functools32 == 3.2.3-2 10:34:41 INFO - jsonschema == 2.5.1 10:34:41 INFO - manifestparser == 1.1 10:34:41 INFO - mozInstall == 1.12 10:34:41 INFO - mozcrash == 0.17 10:34:41 INFO - mozdebug == 0.1 10:34:41 INFO - mozdevice == 0.48 10:34:41 INFO - mozfile == 1.2 10:34:41 INFO - mozhttpd == 0.7 10:34:41 INFO - mozinfo == 0.9 10:34:41 INFO - mozleak == 0.1 10:34:41 INFO - mozlog == 3.4 10:34:41 INFO - moznetwork == 0.27 10:34:41 INFO - mozprocess == 0.23 10:34:41 INFO - mozprofile == 0.28 10:34:41 INFO - mozrunner == 6.12 10:34:41 INFO - mozscreenshot == 0.1 10:34:41 INFO - mozsystemmonitor == 0.3 10:34:41 INFO - moztest == 0.7 10:34:41 INFO - mozversion == 1.4 10:34:41 INFO - psutil == 3.1.1 10:34:41 INFO - requests == 1.2.3 10:34:41 INFO - wsgiref == 0.1.2 10:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 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 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:41 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 10:34:41 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 10:34:41 INFO - Using env: {'DISPLAY': ':0', 10:34:41 INFO - 'HOME': '/home/cltbld', 10:34:41 INFO - 'LANG': 'en_US.UTF-8', 10:34:41 INFO - 'LANGUAGE': 'en_US:en', 10:34:41 INFO - 'LOGNAME': 'cltbld', 10:34:41 INFO - 'MAIL': '/var/mail/cltbld', 10:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:41 INFO - 'MOZ_NO_REMOTE': '1', 10:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:41 INFO - 'NO_EM_RESTART': '1', 10:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:41 INFO - 'PWD': '/builds/slave/test', 10:34:41 INFO - 'SHELL': '/bin/bash', 10:34:41 INFO - 'SHLVL': '1', 10:34:41 INFO - 'TERM': 'linux', 10:34:41 INFO - 'TMOUT': '86400', 10:34:41 INFO - 'USER': 'cltbld', 10:34:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:41 INFO - '_': '/tools/buildbot/bin/python'} 10:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 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)) 10:34:41 INFO - Cleaning up... 10:34:41 INFO - Return code: 0 10:34:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d3082ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', '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 10:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:34:41 INFO - Using env: {'DISPLAY': ':0', 10:34:41 INFO - 'HOME': '/home/cltbld', 10:34:41 INFO - 'LANG': 'en_US.UTF-8', 10:34:41 INFO - 'LANGUAGE': 'en_US:en', 10:34:41 INFO - 'LOGNAME': 'cltbld', 10:34:41 INFO - 'MAIL': '/var/mail/cltbld', 10:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:41 INFO - 'MOZ_NO_REMOTE': '1', 10:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:41 INFO - 'NO_EM_RESTART': '1', 10:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:41 INFO - 'PWD': '/builds/slave/test', 10:34:41 INFO - 'SHELL': '/bin/bash', 10:34:41 INFO - 'SHLVL': '1', 10:34:41 INFO - 'TERM': 'linux', 10:34:41 INFO - 'TMOUT': '86400', 10:34:41 INFO - 'USER': 'cltbld', 10:34:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:41 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:34:42 INFO - Cleaning up... 10:34:42 INFO - Return code: 0 10:34:42 INFO - Running post-action listener: _resource_record_post_action 10:34:42 INFO - Running post-action listener: _start_resource_monitoring 10:34:42 INFO - Starting resource monitoring. 10:34:42 INFO - [mozharness: 2016-12-15 18:34:42.081878Z] Finished create-virtualenv step (success) 10:34:42 INFO - [mozharness: 2016-12-15 18:34:42.082345Z] Running install step. 10:34:42 INFO - Running pre-action listener: _resource_record_pre_action 10:34:42 INFO - Running main action method: install 10:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:42 INFO - Reading from file tmpfile_stdout 10:34:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:34:42 INFO - Reading from file tmpfile_stdout 10:34:42 INFO - Output received: 10:34:42 INFO - Usage: mozinstall [options] installer 10:34:42 INFO - Options: 10:34:42 INFO - -h, --help show this help message and exit 10:34:42 INFO - -d DEST, --destination=DEST 10:34:42 INFO - Directory to install application into. [default: 10:34:42 INFO - "/builds/slave/test"] 10:34:42 INFO - --app=APP Application being installed. [default: firefox] 10:34:42 INFO - mkdir: /builds/slave/test/build/application 10:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:34:55 INFO - Reading from file tmpfile_stdout 10:34:55 INFO - Output received: 10:34:55 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:55 INFO - Running post-action listener: _resource_record_post_action 10:34:55 INFO - [mozharness: 2016-12-15 18:34:55.877166Z] Finished install step (success) 10:34:55 INFO - [mozharness: 2016-12-15 18:34:55.877412Z] Running run-tests step. 10:34:55 INFO - Running pre-action listener: _resource_record_pre_action 10:34:55 INFO - Running main action method: run_tests 10:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:55 INFO - Python 2.7.3 10:34:55 INFO - Return code: 0 10:34:55 INFO - grabbing minidump binary from tooltool 10:34: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')]} 10:34:55 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 0x1681f60>, '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 0x1682d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16831d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:55 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 10:34:55 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 10:34:55 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 10:34:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:55 INFO - Return code: 0 10:34:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 10:34:55 INFO - Using env: {'DISPLAY': ':0', 10:34:55 INFO - 'HOME': '/home/cltbld', 10:34:55 INFO - 'LANG': 'en_US.UTF-8', 10:34:55 INFO - 'LANGUAGE': 'en_US:en', 10:34:55 INFO - 'LOGNAME': 'cltbld', 10:34:55 INFO - 'MAIL': '/var/mail/cltbld', 10:34:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:55 INFO - 'MOZ_NO_REMOTE': '1', 10:34:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:55 INFO - 'NO_EM_RESTART': '1', 10:34:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:55 INFO - 'PWD': '/builds/slave/test', 10:34:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:55 INFO - 'SHELL': '/bin/bash', 10:34:55 INFO - 'SHLVL': '1', 10:34:55 INFO - 'TERM': 'linux', 10:34:55 INFO - 'TMOUT': '86400', 10:34:55 INFO - 'USER': 'cltbld', 10:34:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902', 10:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:55 INFO - '_': '/tools/buildbot/bin/python'} 10:34:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:34:56 INFO - mozversion application_buildid: 20161215085501 10:34:56 INFO - mozversion application_changeset: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 10:34:56 INFO - mozversion application_display_name: Firefox 10:34:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:56 INFO - mozversion application_name: Firefox 10:34:56 INFO - mozversion application_remotingname: firefox 10:34:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:56 INFO - mozversion application_vendor: Mozilla 10:34:56 INFO - mozversion application_version: 51.0 10:34:56 INFO - mozversion platform_buildid: 20161215085501 10:34:56 INFO - mozversion platform_changeset: ae5275b8c53ba76cb98576e4e2a3031b0d659ba3 10:34:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:56 INFO - mozversion platform_version: 51.0 10:34:56 INFO - using testdate: 1481826896 10:34:56 INFO - actual date: 1481826896 10:34:56 INFO - starting webserver on 'localhost:55415' 10:34:56 INFO - SUITE-START | Running 2 tests 10:34:56 INFO - TEST-START | dromaeo_css 10:34:56 INFO - operating with platform_type : linux_ 10:34:56 INFO - Initialising browser for dromaeo_css test... 10:34:56 INFO - TEST-INFO | started process 8115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIl750/profile http://localhost:55415/getInfo.html) 10:34:59 INFO - PROCESS | 8115 | __metrics Screen width/height:1600/1200 10:34:59 INFO - PROCESS | 8115 | colorDepth:24 10:34:59 INFO - PROCESS | 8115 | Browser inner width/height: 1024/697 10:34:59 INFO - PROCESS | 8115 | __metrics 10:34:59 INFO - PROCESS | 8115 | 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" 10:34:59 INFO - PROCESS | 8115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:00 INFO - PROCESS | 8115 | console.error: PushService: 10:35:00 INFO - PROCESS | 8115 | stateChangeProcessEnqueue: Error transitioning state 10:35:00 INFO - PROCESS | 8115 | UnknownError 10:35:00 INFO - TEST-INFO | 8115: exit 0 10:35:00 INFO - Browser initialized. 10:35:00 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:00 INFO - TEST-INFO | started process 8210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIl750/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:12 INFO - PROCESS | 8210 | RSS: Main: 144105472 10:35:12 INFO - PROCESS | 8210 | 10:36:04 INFO - PROCESS | 8210 | 1481826964015 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] 10:38:12 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55415/tests/dromaeo/cssquery-ext.html) 10:38:13 INFO - PROCESS | 8210 | RSS: Main: 241401856 10:38:13 INFO - PROCESS | 8210 | 10:41:16 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-ext.html (next: http://localhost:55415/tests/dromaeo/cssquery-jquery.html) 10:41:16 INFO - PROCESS | 8210 | RSS: Main: 232128512 10:41:16 INFO - PROCESS | 8210 | 10:44:18 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55415/tests/dromaeo/cssquery-mootools.html) 10:44:19 INFO - PROCESS | 8210 | RSS: Main: 206569472 10:44:19 INFO - PROCESS | 8210 | 10:47:21 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55415/tests/dromaeo/cssquery-prototype.html) 10:47:21 INFO - PROCESS | 8210 | RSS: Main: 176529408 10:47:21 INFO - PROCESS | 8210 | 10:50:24 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55415/tests/dromaeo/cssquery-yui.html) 10:50:24 INFO - PROCESS | 8210 | RSS: Main: 176697344 10:50:24 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | Cycle 1(1): loaded http://localhost:55415/tests/dromaeo/cssquery-yui.html (next: http://localhost:55415/tests/dromaeo/cssquery-dojo.html) 10:53:27 INFO - PROCESS | 8210 | RSS: Main: 267542528 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | __start_tp_report 10:53:27 INFO - PROCESS | 8210 | _x_x_mozilla_page_load 10:53:27 INFO - PROCESS | 8210 | _x_x_mozilla_page_load_details 10:53:27 INFO - PROCESS | 8210 | |i|pagename|runs| 10:53:27 INFO - PROCESS | 8210 | |0;dojo.html;3111.331063821278;3144.8584813683383;3160.98848368522;3177.428062948671;3187.330660561282;5571.637843540167;5625.606207565467;5663.603547751659;5680.289963754531;5686.488216060548;5656.547476201904;5671.6597004179675;5720.056190728525;5722.885542289152;5740.913886291699;5134.409542902558;5147.099257629919;5190.325257716491;5196.220566914955;5237.2144178373355;5054.519820617035;5231.476852314757;5245.186996015605;5258.184981327881;5279.023380674587;5064.215046667754;5090.592752579785;5109.514596113363;5162.845114646548;5163.096458119833;5133.1786914093755;5220.843374698746;5226.294450249244;5228.660137091077;5228.738563071831;5098.133317336024;5139.049275883974;5188.247704082887;5216.191490318969;5230.686158830483;5495.120780675113;5499.560035197174;5539.196816461631;5555.749991250363;5572.275604171472;5982;5998.370171132012;6113.572049956505;6117.632942023492;6120.265568131853;6123.908141377839;6125.693715314216;6135.3864613538735;6149.631022138686;6159.23009623797;5467.343918729738;5508.641938274;5597.804076857331;5604.075327570905;5655.095184770417;6218.5647004710145;6219.968900155471;6260.060990851409;6260.311365749764;6261.123442718023;6011.849703757353;6015.097735339734;6016.217891674142;6016.909746353808;6046.637201767908;5880.794172204038;5936.554758393051;5944.554158438134;5945.702714864239;6006.309274433409;6011.09833524966;6016.157737916695;6017.1275165100815;6023.608465449732;6043.546733994968;5982.282126144891;6040.728167232485;6048.183495228176;6056.515478761688;6069.908951365733;4415.668824838086;4543.659225558096;4584.701994370355;4642.605378542862;4643.721376717408;4100.446439730657;4115.73247738896;4141.213169497846;4142.233686767958;4179.477565304337;5763.567732420085;5797.565182611321;5803.419658034163;5806.4193580641595;5808.041673123972;5931.406859314034;6015.639061656315;6039.939600604026;6112.51099912006;6129.417705317987;5799.710014499258;5865.824025279248;5870.0607902735355;5885.529157667376;5904.645721256738;5328.17413300939;5332.840014799563;5333.173358129496;5335.039692855324;5339.332583427072;6030.698465076816;6089.5432842537875;6306.621602703853;6349.46029587481;6372.330905254881;6003.279606447254;6108.267007959073;6110.984061328701;6121.969390153021;6132.110843927695;6221.160143380766;6227.937720622917;6258.561900667091;6266.342034086355;6267.091271765659;5814.505767009851;6006.819795406145;6007.279126504847;6010.9699451502465;6046.90929636047;6047.123167140652;6055.303640081447;6112;6122.295935967242;6157.72290246931;5952.315483719254;5999.1901093351835;6004.339522652417;6009.248843894513;6025.276966764016;5962.433568810956;5982.820515384546;5987.820365389045;5993.101034844808;5995.550333724901;5660.4905558498285;5777.45114214149;5834.824955251349;5860.619059761102;5891.381404952418;6022.126791615279;6026.0659597762415;6036.849078773066;6043;6046.939530604637;5704.543636509153;5893.5874488785375;5902.2327097477055;5905.763769449346;5909.852253693692 10:53:27 INFO - PROCESS | 8210 | |1;ext.html;598.2014011294921;618.5422787137518;640.9967950160249;657.6317262333096;672.3377473188912;34431.65568344319;38121;45019.87450313748;45501.31748023782;45673.54326456734;47489;47993.76003119988;47994.76002619982;48002.75998620011;48106.278405823854;9257.768555786091;9417.76455588609;9419.717408477756;9422.952885235598;9432.056794320548;8452.070272270046;8662.87005694915;10935.28920620161;11035.172362072837;11139.496168017295;11021.118310535177;11111.333320000786;11113.72215694606;11116.499757510932;11124.443777811117;10962;11030.117590592814;11044.226904116715;11050.99999999992;11051;10197.18422526196;10204.030617091365;10214.693559193236;10237;10371.066604005675;44801.551984480066;45056.77471612621;45076;45155.548444515465;45223.773881130386;3691.557013158438;3765.4728338032696;3782.7730336179916;3831.8275677594575;4164.271252530825;34924.650753492395;34973.82513087444;35235.64764352375;35575;36689.81655091734;4768.2847572864;4785.976070119662;4808.975955120237;4844.103840789465;4893.09477746618;255939;345111;345640;345647;347234;38166.809165954546;61443.38556614466;61703;61815.6909215451;61841.690791545756;39413.40879886804;42212.78893605512;42260.36609450861;42279;42299.36550951738;17378.739318910226;17488.125593720262;17517.386891458736;17539.912300438416;17545.385911493035;13139.211647301192;13145.474181032843;13175.07774455798;13321.40053697586;13548.051636385555;9297.535123243812;9574.664886728931;9607.951960240154;9659.32384733062;9743.171830394496;3683.116052147519;3690.022144131807;3692.6307369263395;3694.9630503695157;3745.419459983707;1061.0927656853435;1066.57337065173;1083.8103331916882;1139.3448766959032;1151.83874257604;34190.31619367649;34229.65770342265;34475.65524344775;34520.82739586286;34623;1010.1161483701761;1033.6743925663393;1052.7631282961272;1120.2606279855256;1138.6584024792528;17636.559086022695;18307.08464576766;18307.35924242645;18309.7253541197;18347.724784128248;537550;538911;539042;543250;544961;61964.69017654883;62126.68936655288;62473;62492.68753656203;62598.68700656467;1334.8531661517225;1361.9455221791216;1399.6221020324658;1429.2067902314316;1465.5456808389433;30503;35560.288794224485;35638.9109697925;35665;35986;53655.46344536504;57968.42031579799;59866.70066649639;60202.39797602143;66577.66711166414;394186;399707;401817;402006;402197;38573;39801.80099099486;41859;46004.7699761499;46498;50702.49297506978;51120.74439627778;51216.74391628018;51472.48527514677;51628.48371516387;42395.57604423916;42866;43751.34372984472;44038;44844.55155448404;42941;43035;43426.782866085465;44481.33278000768;44883.102337953715;42947.35578966381;43474.56525434705;43911.78044109759;44352.334714979945;44451;36621;39461.408078879416;39560.40659390054;39792.2041559173;39871.60128398795;29113.943035980916;29208.561871571517;29563.55654665225;29568.704312956594;29709.405811884073 10:53:27 INFO - PROCESS | 8210 | |2;jquery.html;395.88915103770955;406.3944722363679;414.20059285578833;423.1938157809373;432.4615853262686;19009.71485427718;20400.591988160228;20690.482737931557;21695.240666576672;21941.341759747233;18074;18239.088045597735;18394.816051839476;18550.536236594056;18587.907060464713;6427.582207156532;6713;6727.0918426012595;6741.696623651923;6830.248672646005;6534.934650653504;6662.267150613453;6703.798886033427;6751.56114852533;6776.627285499296;6812.761553345634;6817.011533327664;6821.079154314179;6822.113125293705;6824.897626535606;6554.705038273265;6710.83222919426;6735.595864248161;6743.460523158135;6746.966265168692;6370.872582548323;6548.050532672783;6550.312217217172;6675.032120342523;6718.462522998148;26966.5955010675;27113.322166945785;27371.45257094847;27470.17589472299;27518.587221191698;2753.2979090332037;2857.1142945686697;2879.726425989528;2991.0428662827903;3388.81361525116;15651.686966260724;16998.405055822986;17298.22158002893;17462.47612571625;17732.822671773247;2088.832893368527;2089.937301880946;2121.31057406342;2171.815395691368;2213.0262684418803;88859;96156.51921740416;101770.49114754378;103741.48129259306;106039.46980265126;18206.45380638583;18529.258829646664;18617.53456163607;18714.064296785105;19310.903445482683;34617.82691086528;34720.47919281213;34746.826265869015;34865.82567087148;34902.65097348994;10770;10994.615188468366;11016.614418495474;11112.388818614892;11119.221654484109;9379.062093790702;9446.527673616292;9542.33203675736;9684.176844968115;9691.806163876683;9340.953295233481;9410.294227932933;9578.329516933887;9621.56702948355;9759.902400976041;3496.9125771855397;3515.535270206823;3544.946825797615;3561.702701757352;3585.8027808470783;817.1746535998684;934.621478301289;966;993.8658281132099;1002.173207104142;18746.25014999412;20181.899090504452;20232.190712371634;20253.08861101254;20705.68941465879;968.5254225429488;1000.8490236228396;1011.9898801012043;1043.1758910460803;1061.7717190804015;9515.809683806423;11134.276272042453;11205.17755797787;11207.66377008691;11354.602588909349;462142;463210;496944;514918;518465;74034;76010.61994689991;95669.52165239268;98143.50928245456;102562;977.8093271811929;1037.5175543372218;1038.3873514626407;1041.234692501011;1059.9629012984662;17918.283268669627;18306.90846545759;18342.541436464195;18368.448946531626;18514.907425463327;44779.32831007472;45575.77212113918;46173;46356;46870.76564617291;62858;63921.680391599606;64686.67656661875;64959.675201623686;65614;8012.158723333966;8573.399862009599;8697.826043479221;9070.365074444726;9546.809063818824;10618.893811061791;13532.72934541284;14127.576172714835;14496.347664354918;15028.323725432163;9319.021502742115;11130.332180069221;12312.199707019015;12431;12669.556565520163;12434.56479023266;12554.62336129881;12592.622221333375;12805.679858003252;12824.935875320936;9493.813273340833;12378.381080945737;12606.747865042831;12825.486980520674;13004.609861704164;8696.391252612257;8767.912320876965;8792.42849214799;8806.91193088061;8818.647254109765;12030.518779248732;12489.250644961332;12521.686957825763;12589;12680.175788574083 10:53:27 INFO - PROCESS | 8210 | |3;mootools.html;1385.272731815797;1469.9485518006873;1538.6461113943792;1653.388246348851;1728.5419363868568;8736.12638736126;9340.579673914674;9343.906560934389;9353.579088940996;9373.859392109123;8122.837543249131;8315.168483151681;8337.124601916803;8604.8709269361;9152.816943661122;2382.8451150675196;2444.352246654638;2452.9877350613224;2463;2464.0267094497663;2504.874756262189;2510.8619025953567;2527.9620805687928;2584.625229341744;2588.327034970912;2546.745325467448;2567.499337629163;2570.4345044090364;2579.445419234864;2580.5484040292968;2499.0753421234076;2503.4492411669403;2505.2734706934966;2507.887145078476;2508.0845491395507;2509.535735888848;2511.8869650865754;2515.962260566093;2518.508890766301;2519.231634351522;9252.074792520762;9261.120193581599;9340.486273254968;9349.111834375792;9361.812763744754;5632.493075623213;5704.857378565527;5744.368119506851;5769.480746732815;5774.855628609318;3605.657462541081;3632.4914511968345;3783.39465685489;3814.771113733185;3848.499695039655;1296.4490091710986;1343.20079552667;1351.6350585341902;1369.370089758712;1386.2860626777217;12856.614301570968;12865.807012894815;12898.742025159445;12938.223706577635;12956.870431295662;5068.467810879878;5108.872278193001;5165.251038599382;5166.61250406221;5213.45258747826;10873.565057397616;10875.510602022929;10877.292975956696;10878.72803179911;10883.129349652008;5758.913616295759;5770.798022069292;5772;5775.393583673737;5778.3354914184565;5221.347331583552;5278.392984806719;5288.101022826128;5299;5343.572514198855;4322.265214913472;4353.412289340962;4420.955790442119;4464.2187617166865;4465.151621191963;1392.3943084758162;1413.3639862062114;1414.7948547460767;1425.9714805703827;1444.1768192130385;837.8073043200098;960.1502670136979;980.3872579637726;998.0917365197636;1009.8535712321819;5852.297724273029;5855.941440585625;5875.265591801025;5938.376470470625;6148.6925653717135;513.8021861583318;517.7152566088636;519.948005199477;520.3443660987183;525.6819624127425;4149.25313443583;4156.896077598024;4164.021454958082;4229.281022226229;4275.273203555403;11058.22592418523;11531.192816502931;11548.249363791327;11560;11607.36159511235;10903.509342079626;11418.885811141783;11423.200375973769;11429.657110286706;11442.427878606037;8205.548694821722;8392.118827523143;8396.706115285935;8419.200175983395;8434.114417986024;6220.626762394271;6259.2488901332135;6310.873782524232;6490.415862572391;6503.804885853432;10148.847767283349;10534.578616855546;10565.577376904837;10645.946770266099;10660.093892019266;9277.48973806447;10295.845562316421;10567.260291779809;10641.627543035956;10784.191185661264;7606.847863042819;8033.277005069572;8096.433249672702;8104.959475202586;8271.917280827114;8647.264982476308;8834.558272086499;8896.733098007071;8953.059928707393;8971.50656713861;7903.525788452481;7933.920660793318;7960.522368657899;8126;8324.958375208085;7863.174366691415;7865.803354916173;7976.601169941596;7993.400494963017;8032.799180020546;7357.705691772269;7379.040724705754;7400.962995184989;7421.0723659542555;7423.554586724814;5111.591072714248;5149.169174865125;5168.276441298146;5216.15182959052;5430.972845135907;5525.226468294361;5583.078791999437;5594.580406469449;5674.631148975303;5689.516391106637 10:53:27 INFO - PROCESS | 8210 | |4;prototype.html;349.12892333627605;356.40658303923965;359.2868156708931;360.2255151424436;363.76173606287875;5637.520810731087;5651.37834838168;5659.915101273479;5667.659940403579;5736.942630573693;5580.888382232363;5627.549796016319;5662.490375866171;5671.8014869479575;5684.175794509793;4182.707210495274;4387.714798538101;4397.846075387362;4401.625861801751;4408.955910440886;4368.366586844922;4380.189664911985;4397.868063958071;4402.60376566109;4403.317485789692;4126.277901367263;4268.6798490113215;4363.934540981888;4368.148211098837;4373.650107991353;4010.8796736097966;4260;4262.509811371701;4326.069894972565;4337.306031035051;3806.7144964127524;3812.8093595320124;3830.5826844067597;3831.1571454280015;3837.2901013312626;5417.6478528895495;5427.538659213971;5431.293931788881;5443.945560544423;5445.754941027663;4792.329073929653;4936.111499930011;4966.801327946878;4984.3021976923255;4984.45481900612;5744.310682718101;5758.74085666146;5770.567207459458;5772.826815195551;5791.262621213619;4187.560306167839;4214.726042807239;4225.429567008476;4231.61915427613;4233.618974292298;5750.539956803487;5757;5925.377835327272;6045.3652366501765;6050.183225264577;4151.481064866892;4247.00195454068;4271.1671224111;4274.252005899018;4279.422277992493;4340.978295108504;4394.494633117169;4405.801738921757;4406.933895991563;4409.757463339547;4911.7298548580175;4956.653034287638;5018.749062546858;5039.874003149877;5044.268581055726;5821.505172060422;5835.44563266489;5848.502877255481;5848.970755146197;5853.619514731528;1482.5255918106102;1497.2064805653022;1500.5948393933577;1506.5329747778005;1507.9547613571392;915.1031988651159;949.9097585729345;955.1642312976146;963.8361478548663;982.6020461713018;4978.8755281118265;4992.375953005874;5013.974930125326;5035.521625445577;5064.265681476165;5247.790088396421;5252.2384254282915;5287.920681189786;5320.414754377015;5327.547158491494;5053.877371503977;5065.530996011189;5076.730817295676;5361;5706.771729130788;3200.3599280144063;3226.6450690424035;3230.305484320835;3245.010271867056;3250.2849373138347;6105.32841387447;6181.629102253789;6191.876162476815;6201.883660941074;6207.579044172776;6187.907181392283;6191.721372538246;6198.504119670415;6236.222676537165;6237.157983672237;6173.783917562864;6176.845578860474;6195.96902015487;6197.659128747962;6226.40849119333;5776.42235776419;5969.820905372846;5978.551608629283;6040.36576159497;6051.425114614105;5957.719090395586;5966.955782737917;5983.611065280743;5999.340072591924;6031.939680603138;5898.672798620276;5969.0453225651845;6096.359882212481;6167.691615419121;6208.875822483435;4284.935725964051;4309.827606895689;4311.202427550913;4311.805968731352;4314.935275970925;5783.595148339576;6065.302490213506;6076.270847498152;6112.144299797943;6118.510519158545;5829.300483941955;5846.94153058464;5861.35525092248;5875.3243377012195;5884.7940322088525;5857.092150716646;5893.233879595625;5903.704814759159;5908.084246941731;5946.97026514882;5590.916136257878;5862.355140934579;5863.5341164708825;5867.647941123546;5885.705714714161;5929.258842644669;5936.970315148569;5938.435848594377;5939.227900372924;5946.524278057658;5635.380108188178;5819.738111784895;5832.912506312324;5859.20900678403;5864.32560255576 10:53:27 INFO - PROCESS | 8210 | |5;yui.html;789.2265579731866;809.8299357135003;811.3184924663282;833.1127349372917;882.3250213586604;15663.295151718172;16739.330426782915;16809.411670591533;16920.83079169208;16971.406000789975;16210.513684589452;16349.509514714548;16382.508524744277;16384.75422868658;16411.343546258136;716.2694052066888;736.462382460804;835.3651225068961;843.7215718812807;864.1315477944656;870.0559892516627;870.6691457246237;872.1932212703256;872.8472517309477;873.388627960427;918.169057003413;919.4575200631626;921.7603423110006;923.1460898668738;923.3951761596165;912.1061359867301;914.7484441778497;914.8490499067645;915.4919019943961;915.5102020419077;672.5897202706394;673.5689158938284;673.8214373191108;674.2381109346456;674.5615350022475;14767.04014239071;14897.329620167118;14906.254687265702;14936.925315373463;14973.625659358495;16587.881392350657;16671.49985500437;16807.747883781754;17056.403025894033;17374.47876563705;13386.330683465787;13429.932850335783;13633.659158521017;14021.579352619336;14035.401305826548;3966.8214930328204;3967.761934283952;3982.3429134192825;4044.170944956277;4188.7905604719945;89553;91296;93484.53257733736;93553;93666.06333936642;11998.520059197708;12299.446524906401;12501.124921255425;12555.121141520005;12575.434105465276;24779.87610061938;24996.125135620165;25058.498830023662;25075.4984900301;25096;8207.466514676646;8555.230029297392;8636.568171591522;8870.822583548294;8937.821243575092;5258.553022993012;5335.786568537293;5376.38171610262;5407.188921661704;5504;3783.791891445942;3961.4652021976663;3962.9603703963166;3963.3856752203455;3974.344233201547;633.9619622822645;637.6429199648212;639.9488040956712;647.4334956912701;669.494531628627;656.8390744267685;695.384584642595;709.0923617769264;737.6422435118963;757.602258814116;10252.692419227435;10555.313904596176;10571.365718056788;10900.836487452694;11057.336559806437;682.5870348439222;685.3078390825302;755.7657126290867;761.8133557278392;809.7692157735135;4970.701757894538;5344.171653393731;5390.299261096033;5408.8377348679605;5444.237806707064;91802;109950.45024774985;119066;139806.3009684945;140459;101777.49111254397;105189;106667;108814;109110.45444772726;85969;90417.54791226002;91404.08595914088;91667.08332916719;94549.5272523633;10777.784444311226;11152;11229.66311010671;11347.205695601559;11446.141539384413;48489;52207.73896130495;53137;53246.2013069812;53855.73072134614;75073;76954.6152269235;77242;78671;80383;13983.44066237339;14195.858041419453;14197.716045679235;14522;14594.708105838035;15619.687606247584;16113;16360.345586176896;16696.41562545305;16848.410305639245;14298.714537905302;14462.710745784814;14946.626334341729;16321.67356652884;16326.510204693877;14491.565253042425;14517.128972261698;14534.345954432287;15266.542003739905;15367.154806485303;14386.208758517963;14530.927345363205;14696.926515367355;15430.845691542941;15820.762688559911;11235;11367.431628418712;11467.254628449124;11889.643310700692;12098.697532561757;12143.514259429878;12201.630911062482;12206.267623942593;12302;12331.75336493283 10:53:27 INFO - PROCESS | 8210 | __end_tp_report 10:53:27 INFO - PROCESS | 8210 | __start_cc_report 10:53:27 INFO - PROCESS | 8210 | _x_x_mozilla_cycle_collect,842 10:53:27 INFO - PROCESS | 8210 | __end_cc_report 10:53:27 INFO - PROCESS | 8210 | __startTimestamp1481828007618__endTimestamp 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | ------- Summary: start ------- 10:53:27 INFO - PROCESS | 8210 | Number of tests: 6 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#0] dojo.html Cycles:165 Average:5637.90 Median:5893.59 stddev:657.13 (11.1%) stddev-sans-first:628.54 10:53:27 INFO - PROCESS | 8210 | Values: 3111.3 3144.9 3161.0 3177.4 3187.3 5571.6 5625.6 5663.6 5680.3 5686.5 5656.5 5671.7 5720.1 5722.9 5740.9 5134.4 5147.1 5190.3 5196.2 5237.2 5054.5 5231.5 5245.2 5258.2 5279.0 5064.2 5090.6 5109.5 5162.8 5163.1 5133.2 5220.8 5226.3 5228.7 5228.7 5098.1 5139.0 5188.2 5216.2 5230.7 5495.1 5499.6 5539.2 5555.7 5572.3 5982.0 5998.4 6113.6 6117.6 6120.3 6123.9 6125.7 6135.4 6149.6 6159.2 5467.3 5508.6 5597.8 5604.1 5655.1 6218.6 6220.0 6260.1 6260.3 6261.1 6011.8 6015.1 6016.2 6016.9 6046.6 5880.8 5936.6 5944.6 5945.7 6006.3 6011.1 6016.2 6017.1 6023.6 6043.5 5982.3 6040.7 6048.2 6056.5 6069.9 4415.7 4543.7 4584.7 4642.6 4643.7 4100.4 4115.7 4141.2 4142.2 4179.5 5763.6 5797.6 5803.4 5806.4 5808.0 5931.4 6015.6 6039.9 6112.5 6129.4 5799.7 5865.8 5870.1 5885.5 5904.6 5328.2 5332.8 5333.2 5335.0 5339.3 6030.7 6089.5 6306.6 6349.5 6372.3 6003.3 6108.3 6111.0 6122.0 6132.1 6221.2 6227.9 6258.6 6266.3 6267.1 5814.5 6006.8 6007.3 6011.0 6046.9 6047.1 6055.3 6112.0 6122.3 6157.7 5952.3 5999.2 6004.3 6009.2 6025.3 5962.4 5982.8 5987.8 5993.1 5995.6 5660.5 5777.5 5834.8 5860.6 5891.4 6022.1 6026.1 6036.8 6043.0 6046.9 5704.5 5893.6 5902.2 5905.8 5909.9 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#1] ext.html Cycles:180 Average:59692.45 Median:39676.31 stddev:114495.39 (288.6%) stddev-sans-first:114730.61 10:53:27 INFO - PROCESS | 8210 | Values: 598.2 618.5 641.0 657.6 672.3 34431.7 38121.0 45019.9 45501.3 45673.5 47489.0 47993.8 47994.8 48002.8 48106.3 9257.8 9417.8 9419.7 9423.0 9432.1 8452.1 8662.9 10935.3 11035.2 11139.5 11021.1 11111.3 11113.7 11116.5 11124.4 10962.0 11030.1 11044.2 11051.0 11051.0 10197.2 10204.0 10214.7 10237.0 10371.1 44801.6 45056.8 45076.0 45155.5 45223.8 3691.6 3765.5 3782.8 3831.8 4164.3 34924.7 34973.8 35235.6 35575.0 36689.8 4768.3 4786.0 4809.0 4844.1 4893.1 255939.0 345111.0 345640.0 345647.0 347234.0 38166.8 61443.4 61703.0 61815.7 61841.7 39413.4 42212.8 42260.4 42279.0 42299.4 17378.7 17488.1 17517.4 17539.9 17545.4 13139.2 13145.5 13175.1 13321.4 13548.1 9297.5 9574.7 9608.0 9659.3 9743.2 3683.1 3690.0 3692.6 3695.0 3745.4 1061.1 1066.6 1083.8 1139.3 1151.8 34190.3 34229.7 34475.7 34520.8 34623.0 1010.1 1033.7 1052.8 1120.3 1138.7 17636.6 18307.1 18307.4 18309.7 18347.7 537550.0 538911.0 539042.0 543250.0 544961.0 61964.7 62126.7 62473.0 62492.7 62598.7 1334.9 1361.9 1399.6 1429.2 1465.5 30503.0 35560.3 35638.9 35665.0 35986.0 53655.5 57968.4 59866.7 60202.4 66577.7 394186.0 399707.0 401817.0 402006.0 402197.0 38573.0 39801.8 41859.0 46004.8 46498.0 50702.5 51120.7 51216.7 51472.5 51628.5 42395.6 42866.0 43751.3 44038.0 44844.6 42941.0 43035.0 43426.8 44481.3 44883.1 42947.4 43474.6 43911.8 44352.3 44451.0 36621.0 39461.4 39560.4 39792.2 39871.6 29113.9 29208.6 29563.6 29568.7 29709.4 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#2] jquery.html Cycles:180 Average:31434.47 Median:34669.15 stddev:81230.46 (234.3%) stddev-sans-first:81424.90 10:53:27 INFO - PROCESS | 8210 | Values: 395.9 406.4 414.2 423.2 432.5 19009.7 20400.6 20690.5 21695.2 21941.3 18074.0 18239.1 18394.8 18550.5 18587.9 6427.6 6713.0 6727.1 6741.7 6830.2 6534.9 6662.3 6703.8 6751.6 6776.6 6812.8 6817.0 6821.1 6822.1 6824.9 6554.7 6710.8 6735.6 6743.5 6747.0 6370.9 6548.1 6550.3 6675.0 6718.5 26966.6 27113.3 27371.5 27470.2 27518.6 2753.3 2857.1 2879.7 2991.0 3388.8 15651.7 16998.4 17298.2 17462.5 17732.8 2088.8 2089.9 2121.3 2171.8 2213.0 88859.0 96156.5 101770.5 103741.5 106039.5 18206.5 18529.3 18617.5 18714.1 19310.9 34617.8 34720.5 34746.8 34865.8 34902.7 10770.0 10994.6 11016.6 11112.4 11119.2 9379.1 9446.5 9542.3 9684.2 9691.8 9341.0 9410.3 9578.3 9621.6 9759.9 3496.9 3515.5 3544.9 3561.7 3585.8 817.2 934.6 966.0 993.9 1002.2 18746.3 20181.9 20232.2 20253.1 20705.7 968.5 1000.8 1012.0 1043.2 1061.8 9515.8 11134.3 11205.2 11207.7 11354.6 462142.0 463210.0 496944.0 514918.0 518465.0 74034.0 76010.6 95669.5 98143.5 102562.0 977.8 1037.5 1038.4 1041.2 1060.0 17918.3 18306.9 18342.5 18368.4 18514.9 44779.3 45575.8 46173.0 46356.0 46870.8 62858.0 63921.7 64686.7 64959.7 65614.0 8012.2 8573.4 8697.8 9070.4 9546.8 10618.9 13532.7 14127.6 14496.3 15028.3 9319.0 11130.3 12312.2 12431.0 12669.6 12434.6 12554.6 12592.6 12805.7 12824.9 9493.8 12378.4 12606.7 12825.5 13004.6 8696.4 8767.9 8792.4 8806.9 8818.6 12030.5 12489.3 12521.7 12589.0 12680.2 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#3] mootools.html Cycles:180 Average:6078.92 Median:5165.93 stddev:3410.59 (66.0%) stddev-sans-first:3401.91 10:53:27 INFO - PROCESS | 8210 | Values: 1385.3 1469.9 1538.6 1653.4 1728.5 8736.1 9340.6 9343.9 9353.6 9373.9 8122.8 8315.2 8337.1 8604.9 9152.8 2382.8 2444.4 2453.0 2463.0 2464.0 2504.9 2510.9 2528.0 2584.6 2588.3 2546.7 2567.5 2570.4 2579.4 2580.5 2499.1 2503.4 2505.3 2507.9 2508.1 2509.5 2511.9 2516.0 2518.5 2519.2 9252.1 9261.1 9340.5 9349.1 9361.8 5632.5 5704.9 5744.4 5769.5 5774.9 3605.7 3632.5 3783.4 3814.8 3848.5 1296.4 1343.2 1351.6 1369.4 1386.3 12856.6 12865.8 12898.7 12938.2 12956.9 5068.5 5108.9 5165.3 5166.6 5213.5 10873.6 10875.5 10877.3 10878.7 10883.1 5758.9 5770.8 5772.0 5775.4 5778.3 5221.3 5278.4 5288.1 5299.0 5343.6 4322.3 4353.4 4421.0 4464.2 4465.2 1392.4 1413.4 1414.8 1426.0 1444.2 837.8 960.2 980.4 998.1 1009.9 5852.3 5855.9 5875.3 5938.4 6148.7 513.8 517.7 519.9 520.3 525.7 4149.3 4156.9 4164.0 4229.3 4275.3 11058.2 11531.2 11548.2 11560.0 11607.4 10903.5 11418.9 11423.2 11429.7 11442.4 8205.5 8392.1 8396.7 8419.2 8434.1 6220.6 6259.2 6310.9 6490.4 6503.8 10148.8 10534.6 10565.6 10645.9 10660.1 9277.5 10295.8 10567.3 10641.6 10784.2 7606.8 8033.3 8096.4 8105.0 8271.9 8647.3 8834.6 8896.7 8953.1 8971.5 7903.5 7933.9 7960.5 8126.0 8325.0 7863.2 7865.8 7976.6 7993.4 8032.8 7357.7 7379.0 7401.0 7421.1 7423.6 5111.6 5149.2 5168.3 5216.2 5431.0 5525.2 5583.1 5594.6 5674.6 5689.5 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#4] prototype.html Cycles:180 Average:4889.11 Median:5609.23 stddev:1435.61 (25.6%) stddev-sans-first:1398.61 10:53:27 INFO - PROCESS | 8210 | Values: 349.1 356.4 359.3 360.2 363.8 5637.5 5651.4 5659.9 5667.7 5736.9 5580.9 5627.5 5662.5 5671.8 5684.2 4182.7 4387.7 4397.8 4401.6 4409.0 4368.4 4380.2 4397.9 4402.6 4403.3 4126.3 4268.7 4363.9 4368.1 4373.7 4010.9 4260.0 4262.5 4326.1 4337.3 3806.7 3812.8 3830.6 3831.2 3837.3 5417.6 5427.5 5431.3 5443.9 5445.8 4792.3 4936.1 4966.8 4984.3 4984.5 5744.3 5758.7 5770.6 5772.8 5791.3 4187.6 4214.7 4225.4 4231.6 4233.6 5750.5 5757.0 5925.4 6045.4 6050.2 4151.5 4247.0 4271.2 4274.3 4279.4 4341.0 4394.5 4405.8 4406.9 4409.8 4911.7 4956.7 5018.7 5039.9 5044.3 5821.5 5835.4 5848.5 5849.0 5853.6 1482.5 1497.2 1500.6 1506.5 1508.0 915.1 949.9 955.2 963.8 982.6 4978.9 4992.4 5014.0 5035.5 5064.3 5247.8 5252.2 5287.9 5320.4 5327.5 5053.9 5065.5 5076.7 5361.0 5706.8 3200.4 3226.6 3230.3 3245.0 3250.3 6105.3 6181.6 6191.9 6201.9 6207.6 6187.9 6191.7 6198.5 6236.2 6237.2 6173.8 6176.8 6196.0 6197.7 6226.4 5776.4 5969.8 5978.6 6040.4 6051.4 5957.7 5967.0 5983.6 5999.3 6031.9 5898.7 5969.0 6096.4 6167.7 6208.9 4284.9 4309.8 4311.2 4311.8 4314.9 5783.6 6065.3 6076.3 6112.1 6118.5 5829.3 5846.9 5861.4 5875.3 5884.8 5857.1 5893.2 5903.7 5908.1 5947.0 5590.9 5862.4 5863.5 5867.6 5885.7 5929.3 5937.0 5938.4 5939.2 5946.5 5635.4 5819.7 5832.9 5859.2 5864.3 10:53:27 INFO - PROCESS | 8210 | 10:53:27 INFO - PROCESS | 8210 | [#5] yui.html Cycles:180 Average:22531.90 Median:3962.21 stddev:32246.33 (813.8%) stddev-sans-first:32295.46 10:53:27 INFO - PROCESS | 8210 | Values: 789.2 809.8 811.3 833.1 882.3 15663.3 16739.3 16809.4 16920.8 16971.4 16210.5 16349.5 16382.5 16384.8 16411.3 716.3 736.5 835.4 843.7 864.1 870.1 870.7 872.2 872.8 873.4 918.2 919.5 921.8 923.1 923.4 912.1 914.7 914.8 915.5 915.5 672.6 673.6 673.8 674.2 674.6 14767.0 14897.3 14906.3 14936.9 14973.6 16587.9 16671.5 16807.7 17056.4 17374.5 13386.3 13429.9 13633.7 14021.6 14035.4 3966.8 3967.8 3982.3 4044.2 4188.8 89553.0 91296.0 93484.5 93553.0 93666.1 11998.5 12299.4 12501.1 12555.1 12575.4 24779.9 24996.1 25058.5 25075.5 25096.0 8207.5 8555.2 8636.6 8870.8 8937.8 5258.6 5335.8 5376.4 5407.2 5504.0 3783.8 3961.5 3963.0 3963.4 3974.3 634.0 637.6 639.9 647.4 669.5 656.8 695.4 709.1 737.6 757.6 10252.7 10555.3 10571.4 10900.8 11057.3 682.6 685.3 755.8 761.8 809.8 4970.7 5344.2 5390.3 5408.8 5444.2 91802.0 109950.5 119066.0 139806.3 140459.0 101777.5 105189.0 106667.0 108814.0 109110.5 85969.0 90417.5 91404.1 91667.1 94549.5 10777.8 11152.0 11229.7 11347.2 11446.1 48489.0 52207.7 53137.0 53246.2 53855.7 75073.0 76954.6 77242.0 78671.0 80383.0 13983.4 14195.9 14197.7 14522.0 14594.7 15619.7 16113.0 16360.3 16696.4 16848.4 14298.7 14462.7 14946.6 16321.7 16326.5 14491.6 14517.1 14534.3 15266.5 15367.2 14386.2 14530.9 14696.9 15430.8 15820.8 11235.0 11367.4 11467.3 11889.6 12098.7 12143.5 12201.6 12206.3 12302.0 12331.8 10:53:27 INFO - PROCESS | 8210 | -------- Summary: end -------- 10:53:27 INFO - PROCESS | 8210 | 10:53:28 INFO - TEST-INFO | 8210: exit 0 10:53:28 INFO - TEST-OK | dromaeo_css | took 1112246ms 10:53:28 INFO - TEST-START | kraken 10:53:28 INFO - operating with platform_type : linux_ 10:53:28 INFO - Initialising browser for kraken test... 10:53:28 INFO - TEST-INFO | started process 8516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFGdohv/profile http://localhost:55415/getInfo.html) 10:53:31 INFO - PROCESS | 8516 | __metrics Screen width/height:1600/1200 10:53:31 INFO - PROCESS | 8516 | colorDepth:24 10:53:31 INFO - PROCESS | 8516 | Browser inner width/height: 1024/697 10:53:31 INFO - PROCESS | 8516 | __metrics 10:53:32 INFO - PROCESS | 8516 | 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" 10:53:32 INFO - PROCESS | 8516 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:53:32 INFO - PROCESS | 8516 | console.error: PushService: 10:53:32 INFO - PROCESS | 8516 | stateChangeProcessEnqueue: Error transitioning state 10:53:32 INFO - PROCESS | 8516 | UnknownError 10:53:33 INFO - TEST-INFO | 8516: exit 0 10:53:33 INFO - Browser initialized. 10:53:33 INFO - Running cycle 1/1 for kraken test... 10:53:33 INFO - TEST-INFO | started process 8610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFGdohv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:45 INFO - PROCESS | 8610 | RSS: Main: 144109568 10:53:45 INFO - PROCESS | 8610 | 10:53:47 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55415/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:48 INFO - PROCESS | 8610 | RSS: Main: 187420672 10:53:48 INFO - PROCESS | 8610 | 10:53:50 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55415/tests/kraken/driver.html?testName=audio-dft) 10:53:51 INFO - PROCESS | 8610 | RSS: Main: 175235072 10:53:51 INFO - PROCESS | 8610 | 10:53:54 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55415/tests/kraken/driver.html?testName=audio-fft) 10:53:54 INFO - PROCESS | 8610 | RSS: Main: 266244096 10:53:54 INFO - PROCESS | 8610 | 10:53:56 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55415/tests/kraken/driver.html?testName=audio-oscillator) 10:53:57 INFO - PROCESS | 8610 | RSS: Main: 172515328 10:53:57 INFO - PROCESS | 8610 | 10:53:59 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55415/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:00 INFO - PROCESS | 8610 | RSS: Main: 174469120 10:54:00 INFO - PROCESS | 8610 | 10:54:03 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55415/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:03 INFO - PROCESS | 8610 | RSS: Main: 210198528 10:54:03 INFO - PROCESS | 8610 | 10:54:07 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55415/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:07 INFO - PROCESS | 8610 | RSS: Main: 209444864 10:54:07 INFO - PROCESS | 8610 | 10:54:10 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55415/tests/kraken/driver.html?testName=json-parse-financial) 10:54:11 INFO - PROCESS | 8610 | RSS: Main: 208769024 10:54:11 INFO - PROCESS | 8610 | 10:54:12 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55415/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:13 INFO - PROCESS | 8610 | RSS: Main: 170180608 10:54:13 INFO - PROCESS | 8610 | 10:54:14 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:15 INFO - PROCESS | 8610 | RSS: Main: 179011584 10:54:15 INFO - PROCESS | 8610 | 10:54:17 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:17 INFO - PROCESS | 8610 | RSS: Main: 187666432 10:54:17 INFO - PROCESS | 8610 | 10:54:20 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:21 INFO - PROCESS | 8610 | RSS: Main: 196124672 10:54:21 INFO - PROCESS | 8610 | 10:54:23 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:24 INFO - PROCESS | 8610 | RSS: Main: 192524288 10:54:24 INFO - PROCESS | 8610 | 10:54:25 INFO - PROCESS | 8610 | Cycle 1(1): loaded http://localhost:55415/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55415/tests/kraken/driver.html?testName=ai-astar) 10:54:26 INFO - PROCESS | 8610 | RSS: Main: 244568064 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | __start_tp_report 10:54:26 INFO - PROCESS | 8610 | _x_x_mozilla_page_load 10:54:26 INFO - PROCESS | 8610 | _x_x_mozilla_page_load_details 10:54:26 INFO - PROCESS | 8610 | |i|pagename|runs| 10:54:26 INFO - PROCESS | 8610 | |0;ai-astar;110;111;110;110;111;110;111;111;111;111 10:54:26 INFO - PROCESS | 8610 | |1;audio-beat-detection;139;115;121;165;126;120;116;115;146;115 10:54:26 INFO - PROCESS | 8610 | |2;audio-dft;161;160;162;163;164;162;160;161;160;163 10:54:26 INFO - PROCESS | 8610 | |3;audio-fft;74;75;76;112;76;76;75;76;101;74 10:54:26 INFO - PROCESS | 8610 | |4;audio-oscillator;81;82;123;81;82;82;111;82;82;109 10:54:26 INFO - PROCESS | 8610 | |5;imaging-gaussian-blur;117;116;117;117;116;116;117;117;116;117 10:54:26 INFO - PROCESS | 8610 | |6;imaging-darkroom;146;147;146;146;145;146;146;145;147;146 10:54:26 INFO - PROCESS | 8610 | |7;imaging-desaturate;95;94;95;95;94;94;95;95;95;94 10:54:26 INFO - PROCESS | 8610 | |8;json-parse-financial;49;55;51;48;49;49;51;48;49;48 10:54:26 INFO - PROCESS | 8610 | |9;json-stringify-tinderbox;57;58;58;59;59;59;59;60;59;58 10:54:26 INFO - PROCESS | 8610 | |10;stanford-crypto-aes;79;73;72;72;73;74;75;73;73;72 10:54:26 INFO - PROCESS | 8610 | |11;stanford-crypto-ccm;130;119;121;119;128;119;128;119;158;119 10:54:26 INFO - PROCESS | 8610 | |12;stanford-crypto-pbkdf2;153;150;151;152;154;150;147;156;156;153 10:54:26 INFO - PROCESS | 8610 | |13;stanford-crypto-sha256-iterative;62;61;61;62;61;61;61;62;60;60 10:54:26 INFO - PROCESS | 8610 | __end_tp_report 10:54:26 INFO - PROCESS | 8610 | __start_cc_report 10:54:26 INFO - PROCESS | 8610 | _x_x_mozilla_cycle_collect,1564 10:54:26 INFO - PROCESS | 8610 | __end_cc_report 10:54:26 INFO - PROCESS | 8610 | __startTimestamp1481828066219__endTimestamp 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | ------- Summary: start ------- 10:54:26 INFO - PROCESS | 8610 | Number of tests: 14 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:54:26 INFO - PROCESS | 8610 | Values: 110.0 111.0 110.0 110.0 111.0 110.0 111.0 111.0 111.0 111.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:123.50 stddev:16.94 (13.7%) stddev-sans-first:17.47 10:54:26 INFO - PROCESS | 8610 | Values: 139.0 115.0 121.0 165.0 126.0 120.0 116.0 115.0 146.0 115.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 10:54:26 INFO - PROCESS | 8610 | Values: 161.0 160.0 162.0 163.0 164.0 162.0 160.0 161.0 160.0 163.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:13.45 (17.8%) stddev-sans-first:13.99 10:54:26 INFO - PROCESS | 8610 | Values: 74.0 75.0 76.0 112.0 76.0 76.0 75.0 76.0 101.0 74.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:16.16 (19.7%) stddev-sans-first:16.69 10:54:26 INFO - PROCESS | 8610 | Values: 81.0 82.0 123.0 81.0 82.0 82.0 111.0 82.0 82.0 109.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:54:26 INFO - PROCESS | 8610 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:54:26 INFO - PROCESS | 8610 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 145.0 147.0 146.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:54:26 INFO - PROCESS | 8610 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.00 stddev:2.16 (4.4%) stddev-sans-first:2.28 10:54:26 INFO - PROCESS | 8610 | Values: 49.0 55.0 51.0 48.0 49.0 49.0 51.0 48.0 49.0 48.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.84 (1.4%) stddev-sans-first:0.67 10:54:26 INFO - PROCESS | 8610 | Values: 57.0 58.0 58.0 59.0 59.0 59.0 59.0 60.0 59.0 58.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.12 (2.9%) stddev-sans-first:1.00 10:54:26 INFO - PROCESS | 8610 | Values: 79.0 73.0 72.0 72.0 73.0 74.0 75.0 73.0 73.0 72.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:124.50 stddev:12.10 (9.7%) stddev-sans-first:12.75 10:54:26 INFO - PROCESS | 8610 | Values: 130.0 119.0 121.0 119.0 128.0 119.0 128.0 119.0 158.0 119.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:153.00 stddev:2.82 (1.8%) stddev-sans-first:2.98 10:54:26 INFO - PROCESS | 8610 | Values: 153.0 150.0 151.0 152.0 154.0 150.0 147.0 156.0 156.0 153.0 10:54:26 INFO - PROCESS | 8610 | 10:54:26 INFO - PROCESS | 8610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 10:54:26 INFO - PROCESS | 8610 | Values: 62.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 60.0 60.0 10:54:26 INFO - PROCESS | 8610 | -------- Summary: end -------- 10:54:26 INFO - PROCESS | 8610 | 10:54:27 INFO - TEST-INFO | 8610: exit 0 10:54:27 INFO - TEST-OK | kraken | took 58796ms 10:54:27 INFO - SUITE-END | took 1171s 10:54:27 INFO - Completed test suite (00:19:31) 10:54:27 INFO - javascript benchmark 10:54:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.331063821278, 3144.8584813683383, 3160.98848368522, 3177.428062948671, 3187.330660561282, 5571.637843540167, 5625.606207565467, 5663.603547751659, 5680.289963754531, 5686.488216060548, 5656.547476201904, 5671.6597004179675, 5720.056190728525, 5722.885542289152, 5740.913886291699, 5134.409542902558, 5147.099257629919, 5190.325257716491, 5196.220566914955, 5237.2144178373355, 5054.519820617035, 5231.476852314757, 5245.186996015605, 5258.184981327881, 5279.023380674587, 5064.215046667754, 5090.592752579785, 5109.514596113363, 5162.845114646548, 5163.096458119833, 5133.1786914093755, 5220.843374698746, 5226.294450249244, 5228.660137091077, 5228.738563071831, 5098.133317336024, 5139.049275883974, 5188.247704082887, 5216.191490318969, 5230.686158830483, 5495.120780675113, 5499.560035197174, 5539.196816461631, 5555.749991250363, 5572.275604171472, 5982.0, 5998.370171132012, 6113.572049956505, 6117.632942023492, 6120.265568131853, 6123.908141377839, 6125.693715314216, 6135.3864613538735, 6149.631022138686, 6159.23009623797, 5467.343918729738, 5508.641938274, 5597.804076857331, 5604.075327570905, 5655.095184770417, 6218.5647004710145, 6219.968900155471, 6260.060990851409, 6260.311365749764, 6261.123442718023, 6011.849703757353, 6015.097735339734, 6016.217891674142, 6016.909746353808, 6046.637201767908, 5880.794172204038, 5936.554758393051, 5944.554158438134, 5945.702714864239, 6006.309274433409, 6011.09833524966, 6016.157737916695, 6017.1275165100815, 6023.608465449732, 6043.546733994968, 5982.282126144891, 6040.728167232485, 6048.183495228176, 6056.515478761688, 6069.908951365733, 4415.668824838086, 4543.659225558096, 4584.701994370355, 4642.605378542862, 4643.721376717408, 4100.446439730657, 4115.73247738896, 4141.213169497846, 4142.233686767958, 4179.477565304337, 5763.567732420085, 5797.565182611321, 5803.419658034163, 5806.4193580641595, 5808.041673123972, 5931.406859314034, 6015.639061656315, 6039.939600604026, 6112.51099912006, 6129.417705317987, 5799.710014499258, 5865.824025279248, 5870.0607902735355, 5885.529157667376, 5904.645721256738, 5328.17413300939, 5332.840014799563, 5333.173358129496, 5335.039692855324, 5339.332583427072, 6030.698465076816, 6089.5432842537875, 6306.621602703853, 6349.46029587481, 6372.330905254881, 6003.279606447254, 6108.267007959073, 6110.984061328701, 6121.969390153021, 6132.110843927695, 6221.160143380766, 6227.937720622917, 6258.561900667091, 6266.342034086355, 6267.091271765659, 5814.505767009851, 6006.819795406145, 6007.279126504847, 6010.9699451502465, 6046.90929636047, 6047.123167140652, 6055.303640081447, 6112.0, 6122.295935967242, 6157.72290246931, 5952.315483719254, 5999.1901093351835, 6004.339522652417, 6009.248843894513, 6025.276966764016, 5962.433568810956, 5982.820515384546, 5987.820365389045, 5993.101034844808, 5995.550333724901, 5660.4905558498285, 5777.45114214149, 5834.824955251349, 5860.619059761102, 5891.381404952418, 6022.126791615279, 6026.0659597762415, 6036.849078773066, 6043.0, 6046.939530604637, 5704.543636509153, 5893.5874488785375, 5902.2327097477055, 5905.763769449346, 5909.852253693692], "value": 5591.394688336149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.2014011294921, 618.5422787137518, 640.9967950160249, 657.6317262333096, 672.3377473188912, 34431.65568344319, 38121.0, 45019.87450313748, 45501.31748023782, 45673.54326456734, 47489.0, 47993.76003119988, 47994.76002619982, 48002.75998620011, 48106.278405823854, 9257.768555786091, 9417.76455588609, 9419.717408477756, 9422.952885235598, 9432.056794320548, 8452.070272270046, 8662.87005694915, 10935.28920620161, 11035.172362072837, 11139.496168017295, 11021.118310535177, 11111.333320000786, 11113.72215694606, 11116.499757510932, 11124.443777811117, 10962.0, 11030.117590592814, 11044.226904116715, 11050.99999999992, 11051.0, 10197.18422526196, 10204.030617091365, 10214.693559193236, 10237.0, 10371.066604005675, 44801.551984480066, 45056.77471612621, 45076.0, 45155.548444515465, 45223.773881130386, 3691.557013158438, 3765.4728338032696, 3782.7730336179916, 3831.8275677594575, 4164.271252530825, 34924.650753492395, 34973.82513087444, 35235.64764352375, 35575.0, 36689.81655091734, 4768.2847572864, 4785.976070119662, 4808.975955120237, 4844.103840789465, 4893.09477746618, 255939.0, 345111.0, 345640.0, 345647.0, 347234.0, 38166.809165954546, 61443.38556614466, 61703.0, 61815.6909215451, 61841.690791545756, 39413.40879886804, 42212.78893605512, 42260.36609450861, 42279.0, 42299.36550951738, 17378.739318910226, 17488.125593720262, 17517.386891458736, 17539.912300438416, 17545.385911493035, 13139.211647301192, 13145.474181032843, 13175.07774455798, 13321.40053697586, 13548.051636385555, 9297.535123243812, 9574.664886728931, 9607.951960240154, 9659.32384733062, 9743.171830394496, 3683.116052147519, 3690.022144131807, 3692.6307369263395, 3694.9630503695157, 3745.419459983707, 1061.0927656853435, 1066.57337065173, 1083.8103331916882, 1139.3448766959032, 1151.83874257604, 34190.31619367649, 34229.65770342265, 34475.65524344775, 34520.82739586286, 34623.0, 1010.1161483701761, 1033.6743925663393, 1052.7631282961272, 1120.2606279855256, 1138.6584024792528, 17636.559086022695, 18307.08464576766, 18307.35924242645, 18309.7253541197, 18347.724784128248, 537550.0, 538911.0, 539042.0, 543250.0, 544961.0, 61964.69017654883, 62126.68936655288, 62473.0, 62492.68753656203, 62598.68700656467, 1334.8531661517225, 1361.9455221791216, 1399.6221020324658, 1429.2067902314316, 1465.5456808389433, 30503.0, 35560.288794224485, 35638.9109697925, 35665.0, 35986.0, 53655.46344536504, 57968.42031579799, 59866.70066649639, 60202.39797602143, 66577.66711166414, 394186.0, 399707.0, 401817.0, 402006.0, 402197.0, 38573.0, 39801.80099099486, 41859.0, 46004.7699761499, 46498.0, 50702.49297506978, 51120.74439627778, 51216.74391628018, 51472.48527514677, 51628.48371516387, 42395.57604423916, 42866.0, 43751.34372984472, 44038.0, 44844.55155448404, 42941.0, 43035.0, 43426.782866085465, 44481.33278000768, 44883.102337953715, 42947.35578966381, 43474.56525434705, 43911.78044109759, 44352.334714979945, 44451.0, 36621.0, 39461.408078879416, 39560.40659390054, 39792.2041559173, 39871.60128398795, 29113.943035980916, 29208.561871571517, 29563.55654665225, 29568.704312956594, 29709.405811884073], "value": 20520.55167089197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.88915103770955, 406.3944722363679, 414.20059285578833, 423.1938157809373, 432.4615853262686, 19009.71485427718, 20400.591988160228, 20690.482737931557, 21695.240666576672, 21941.341759747233, 18074.0, 18239.088045597735, 18394.816051839476, 18550.536236594056, 18587.907060464713, 6427.582207156532, 6713.0, 6727.0918426012595, 6741.696623651923, 6830.248672646005, 6534.934650653504, 6662.267150613453, 6703.798886033427, 6751.56114852533, 6776.627285499296, 6812.761553345634, 6817.011533327664, 6821.079154314179, 6822.113125293705, 6824.897626535606, 6554.705038273265, 6710.83222919426, 6735.595864248161, 6743.460523158135, 6746.966265168692, 6370.872582548323, 6548.050532672783, 6550.312217217172, 6675.032120342523, 6718.462522998148, 26966.5955010675, 27113.322166945785, 27371.45257094847, 27470.17589472299, 27518.587221191698, 2753.2979090332037, 2857.1142945686697, 2879.726425989528, 2991.0428662827903, 3388.81361525116, 15651.686966260724, 16998.405055822986, 17298.22158002893, 17462.47612571625, 17732.822671773247, 2088.832893368527, 2089.937301880946, 2121.31057406342, 2171.815395691368, 2213.0262684418803, 88859.0, 96156.51921740416, 101770.49114754378, 103741.48129259306, 106039.46980265126, 18206.45380638583, 18529.258829646664, 18617.53456163607, 18714.064296785105, 19310.903445482683, 34617.82691086528, 34720.47919281213, 34746.826265869015, 34865.82567087148, 34902.65097348994, 10770.0, 10994.615188468366, 11016.614418495474, 11112.388818614892, 11119.221654484109, 9379.062093790702, 9446.527673616292, 9542.33203675736, 9684.176844968115, 9691.806163876683, 9340.953295233481, 9410.294227932933, 9578.329516933887, 9621.56702948355, 9759.902400976041, 3496.9125771855397, 3515.535270206823, 3544.946825797615, 3561.702701757352, 3585.8027808470783, 817.1746535998684, 934.621478301289, 966.0, 993.8658281132099, 1002.173207104142, 18746.25014999412, 20181.899090504452, 20232.190712371634, 20253.08861101254, 20705.68941465879, 968.5254225429488, 1000.8490236228396, 1011.9898801012043, 1043.1758910460803, 1061.7717190804015, 9515.809683806423, 11134.276272042453, 11205.17755797787, 11207.66377008691, 11354.602588909349, 462142.0, 463210.0, 496944.0, 514918.0, 518465.0, 74034.0, 76010.61994689991, 95669.52165239268, 98143.50928245456, 102562.0, 977.8093271811929, 1037.5175543372218, 1038.3873514626407, 1041.234692501011, 1059.9629012984662, 17918.283268669627, 18306.90846545759, 18342.541436464195, 18368.448946531626, 18514.907425463327, 44779.32831007472, 45575.77212113918, 46173.0, 46356.0, 46870.76564617291, 62858.0, 63921.680391599606, 64686.67656661875, 64959.675201623686, 65614.0, 8012.158723333966, 8573.399862009599, 8697.826043479221, 9070.365074444726, 9546.809063818824, 10618.893811061791, 13532.72934541284, 14127.576172714835, 14496.347664354918, 15028.323725432163, 9319.021502742115, 11130.332180069221, 12312.199707019015, 12431.0, 12669.556565520163, 12434.56479023266, 12554.62336129881, 12592.622221333375, 12805.679858003252, 12824.935875320936, 9493.813273340833, 12378.381080945737, 12606.747865042831, 12825.486980520674, 13004.609861704164, 8696.391252612257, 8767.912320876965, 8792.42849214799, 8806.91193088061, 8818.647254109765, 12030.518779248732, 12489.250644961332, 12521.686957825763, 12589.0, 12680.175788574083], "value": 10817.769939778382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.272731815797, 1469.9485518006873, 1538.6461113943792, 1653.388246348851, 1728.5419363868568, 8736.12638736126, 9340.579673914674, 9343.906560934389, 9353.579088940996, 9373.859392109123, 8122.837543249131, 8315.168483151681, 8337.124601916803, 8604.8709269361, 9152.816943661122, 2382.8451150675196, 2444.352246654638, 2452.9877350613224, 2463.0, 2464.0267094497663, 2504.874756262189, 2510.8619025953567, 2527.9620805687928, 2584.625229341744, 2588.327034970912, 2546.745325467448, 2567.499337629163, 2570.4345044090364, 2579.445419234864, 2580.5484040292968, 2499.0753421234076, 2503.4492411669403, 2505.2734706934966, 2507.887145078476, 2508.0845491395507, 2509.535735888848, 2511.8869650865754, 2515.962260566093, 2518.508890766301, 2519.231634351522, 9252.074792520762, 9261.120193581599, 9340.486273254968, 9349.111834375792, 9361.812763744754, 5632.493075623213, 5704.857378565527, 5744.368119506851, 5769.480746732815, 5774.855628609318, 3605.657462541081, 3632.4914511968345, 3783.39465685489, 3814.771113733185, 3848.499695039655, 1296.4490091710986, 1343.20079552667, 1351.6350585341902, 1369.370089758712, 1386.2860626777217, 12856.614301570968, 12865.807012894815, 12898.742025159445, 12938.223706577635, 12956.870431295662, 5068.467810879878, 5108.872278193001, 5165.251038599382, 5166.61250406221, 5213.45258747826, 10873.565057397616, 10875.510602022929, 10877.292975956696, 10878.72803179911, 10883.129349652008, 5758.913616295759, 5770.798022069292, 5772.0, 5775.393583673737, 5778.3354914184565, 5221.347331583552, 5278.392984806719, 5288.101022826128, 5299.0, 5343.572514198855, 4322.265214913472, 4353.412289340962, 4420.955790442119, 4464.2187617166865, 4465.151621191963, 1392.3943084758162, 1413.3639862062114, 1414.7948547460767, 1425.9714805703827, 1444.1768192130385, 837.8073043200098, 960.1502670136979, 980.3872579637726, 998.0917365197636, 1009.8535712321819, 5852.297724273029, 5855.941440585625, 5875.265591801025, 5938.376470470625, 6148.6925653717135, 513.8021861583318, 517.7152566088636, 519.948005199477, 520.3443660987183, 525.6819624127425, 4149.25313443583, 4156.896077598024, 4164.021454958082, 4229.281022226229, 4275.273203555403, 11058.22592418523, 11531.192816502931, 11548.249363791327, 11560.0, 11607.36159511235, 10903.509342079626, 11418.885811141783, 11423.200375973769, 11429.657110286706, 11442.427878606037, 8205.548694821722, 8392.118827523143, 8396.706115285935, 8419.200175983395, 8434.114417986024, 6220.626762394271, 6259.2488901332135, 6310.873782524232, 6490.415862572391, 6503.804885853432, 10148.847767283349, 10534.578616855546, 10565.577376904837, 10645.946770266099, 10660.093892019266, 9277.48973806447, 10295.845562316421, 10567.260291779809, 10641.627543035956, 10784.191185661264, 7606.847863042819, 8033.277005069572, 8096.433249672702, 8104.959475202586, 8271.917280827114, 8647.264982476308, 8834.558272086499, 8896.733098007071, 8953.059928707393, 8971.50656713861, 7903.525788452481, 7933.920660793318, 7960.522368657899, 8126.0, 8324.958375208085, 7863.174366691415, 7865.803354916173, 7976.601169941596, 7993.400494963017, 8032.799180020546, 7357.705691772269, 7379.040724705754, 7400.962995184989, 7421.0723659542555, 7423.554586724814, 5111.591072714248, 5149.169174865125, 5168.276441298146, 5216.15182959052, 5430.972845135907, 5525.226468294361, 5583.078791999437, 5594.580406469449, 5674.631148975303, 5689.516391106637], "value": 4828.928455973785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.12892333627605, 356.40658303923965, 359.2868156708931, 360.2255151424436, 363.76173606287875, 5637.520810731087, 5651.37834838168, 5659.915101273479, 5667.659940403579, 5736.942630573693, 5580.888382232363, 5627.549796016319, 5662.490375866171, 5671.8014869479575, 5684.175794509793, 4182.707210495274, 4387.714798538101, 4397.846075387362, 4401.625861801751, 4408.955910440886, 4368.366586844922, 4380.189664911985, 4397.868063958071, 4402.60376566109, 4403.317485789692, 4126.277901367263, 4268.6798490113215, 4363.934540981888, 4368.148211098837, 4373.650107991353, 4010.8796736097966, 4260.0, 4262.509811371701, 4326.069894972565, 4337.306031035051, 3806.7144964127524, 3812.8093595320124, 3830.5826844067597, 3831.1571454280015, 3837.2901013312626, 5417.6478528895495, 5427.538659213971, 5431.293931788881, 5443.945560544423, 5445.754941027663, 4792.329073929653, 4936.111499930011, 4966.801327946878, 4984.3021976923255, 4984.45481900612, 5744.310682718101, 5758.74085666146, 5770.567207459458, 5772.826815195551, 5791.262621213619, 4187.560306167839, 4214.726042807239, 4225.429567008476, 4231.61915427613, 4233.618974292298, 5750.539956803487, 5757.0, 5925.377835327272, 6045.3652366501765, 6050.183225264577, 4151.481064866892, 4247.00195454068, 4271.1671224111, 4274.252005899018, 4279.422277992493, 4340.978295108504, 4394.494633117169, 4405.801738921757, 4406.933895991563, 4409.757463339547, 4911.7298548580175, 4956.653034287638, 5018.749062546858, 5039.874003149877, 5044.268581055726, 5821.505172060422, 5835.44563266489, 5848.502877255481, 5848.970755146197, 5853.619514731528, 1482.5255918106102, 1497.2064805653022, 1500.5948393933577, 1506.5329747778005, 1507.9547613571392, 915.1031988651159, 949.9097585729345, 955.1642312976146, 963.8361478548663, 982.6020461713018, 4978.8755281118265, 4992.375953005874, 5013.974930125326, 5035.521625445577, 5064.265681476165, 5247.790088396421, 5252.2384254282915, 5287.920681189786, 5320.414754377015, 5327.547158491494, 5053.877371503977, 5065.530996011189, 5076.730817295676, 5361.0, 5706.771729130788, 3200.3599280144063, 3226.6450690424035, 3230.305484320835, 3245.010271867056, 3250.2849373138347, 6105.32841387447, 6181.629102253789, 6191.876162476815, 6201.883660941074, 6207.579044172776, 6187.907181392283, 6191.721372538246, 6198.504119670415, 6236.222676537165, 6237.157983672237, 6173.783917562864, 6176.845578860474, 6195.96902015487, 6197.659128747962, 6226.40849119333, 5776.42235776419, 5969.820905372846, 5978.551608629283, 6040.36576159497, 6051.425114614105, 5957.719090395586, 5966.955782737917, 5983.611065280743, 5999.340072591924, 6031.939680603138, 5898.672798620276, 5969.0453225651845, 6096.359882212481, 6167.691615419121, 6208.875822483435, 4284.935725964051, 4309.827606895689, 4311.202427550913, 4311.805968731352, 4314.935275970925, 5783.595148339576, 6065.302490213506, 6076.270847498152, 6112.144299797943, 6118.510519158545, 5829.300483941955, 5846.94153058464, 5861.35525092248, 5875.3243377012195, 5884.7940322088525, 5857.092150716646, 5893.233879595625, 5903.704814759159, 5908.084246941731, 5946.97026514882, 5590.916136257878, 5862.355140934579, 5863.5341164708825, 5867.647941123546, 5885.705714714161, 5929.258842644669, 5936.970315148569, 5938.435848594377, 5939.227900372924, 5946.524278057658, 5635.380108188178, 5819.738111784895, 5832.912506312324, 5859.20900678403, 5864.32560255576], "value": 4433.038724853547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.2265579731866, 809.8299357135003, 811.3184924663282, 833.1127349372917, 882.3250213586604, 15663.295151718172, 16739.330426782915, 16809.411670591533, 16920.83079169208, 16971.406000789975, 16210.513684589452, 16349.509514714548, 16382.508524744277, 16384.75422868658, 16411.343546258136, 716.2694052066888, 736.462382460804, 835.3651225068961, 843.7215718812807, 864.1315477944656, 870.0559892516627, 870.6691457246237, 872.1932212703256, 872.8472517309477, 873.388627960427, 918.169057003413, 919.4575200631626, 921.7603423110006, 923.1460898668738, 923.3951761596165, 912.1061359867301, 914.7484441778497, 914.8490499067645, 915.4919019943961, 915.5102020419077, 672.5897202706394, 673.5689158938284, 673.8214373191108, 674.2381109346456, 674.5615350022475, 14767.04014239071, 14897.329620167118, 14906.254687265702, 14936.925315373463, 14973.625659358495, 16587.881392350657, 16671.49985500437, 16807.747883781754, 17056.403025894033, 17374.47876563705, 13386.330683465787, 13429.932850335783, 13633.659158521017, 14021.579352619336, 14035.401305826548, 3966.8214930328204, 3967.761934283952, 3982.3429134192825, 4044.170944956277, 4188.7905604719945, 89553.0, 91296.0, 93484.53257733736, 93553.0, 93666.06333936642, 11998.520059197708, 12299.446524906401, 12501.124921255425, 12555.121141520005, 12575.434105465276, 24779.87610061938, 24996.125135620165, 25058.498830023662, 25075.4984900301, 25096.0, 8207.466514676646, 8555.230029297392, 8636.568171591522, 8870.822583548294, 8937.821243575092, 5258.553022993012, 5335.786568537293, 5376.38171610262, 5407.188921661704, 5504.0, 3783.791891445942, 3961.4652021976663, 3962.9603703963166, 3963.3856752203455, 3974.344233201547, 633.9619622822645, 637.6429199648212, 639.9488040956712, 647.4334956912701, 669.494531628627, 656.8390744267685, 695.384584642595, 709.0923617769264, 737.6422435118963, 757.602258814116, 10252.692419227435, 10555.313904596176, 10571.365718056788, 10900.836487452694, 11057.336559806437, 682.5870348439222, 685.3078390825302, 755.7657126290867, 761.8133557278392, 809.7692157735135, 4970.701757894538, 5344.171653393731, 5390.299261096033, 5408.8377348679605, 5444.237806707064, 91802.0, 109950.45024774985, 119066.0, 139806.3009684945, 140459.0, 101777.49111254397, 105189.0, 106667.0, 108814.0, 109110.45444772726, 85969.0, 90417.54791226002, 91404.08595914088, 91667.08332916719, 94549.5272523633, 10777.784444311226, 11152.0, 11229.66311010671, 11347.205695601559, 11446.141539384413, 48489.0, 52207.73896130495, 53137.0, 53246.2013069812, 53855.73072134614, 75073.0, 76954.6152269235, 77242.0, 78671.0, 80383.0, 13983.44066237339, 14195.858041419453, 14197.716045679235, 14522.0, 14594.708105838035, 15619.687606247584, 16113.0, 16360.345586176896, 16696.41562545305, 16848.410305639245, 14298.714537905302, 14462.710745784814, 14946.626334341729, 16321.67356652884, 16326.510204693877, 14491.565253042425, 14517.128972261698, 14534.345954432287, 15266.542003739905, 15367.154806485303, 14386.208758517963, 14530.927345363205, 14696.926515367355, 15430.845691542941, 15820.762688559911, 11235.0, 11367.431628418712, 11467.254628449124, 11889.643310700692, 12098.697532561757, 12143.514259429878, 12201.630911062482, 12206.267623942593, 12302.0, 12331.75336493283], "value": 8185.17291102689, "unit": "score"}], "name": "dromaeo_css", "value": 7754.941025563132, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 115.0, 121.0, 165.0, 126.0, 120.0, 116.0, 115.0, 146.0, 115.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 164.0, 162.0, 160.0, 161.0, 160.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 112.0, 76.0, 76.0, 75.0, 76.0, 101.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 123.0, 81.0, 82.0, 82.0, 111.0, 82.0, 82.0, 109.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 55.0, 51.0, 48.0, 49.0, 49.0, 51.0, 48.0, 49.0, 48.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 72.0, 72.0, 73.0, 74.0, 75.0, 73.0, 73.0, 72.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 119.0, 121.0, 119.0, 128.0, 119.0, 128.0, 119.0, 158.0, 119.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 152.0, 154.0, 150.0, 147.0, 156.0, 156.0, 153.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1451.3999999999999, "alertThreshold": 2.0}]} 10:54:27 INFO - Return code: 0 10:54:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:54:27 INFO - # TBPL SUCCESS # 10:54:27 INFO - Running post-action listener: _resource_record_post_action 10:54:27 INFO - [mozharness: 2016-12-15 18:54:27.520736Z] Finished run-tests step (success) 10:54:27 INFO - Running post-run listener: _resource_record_post_run 10:54:27 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320053248; Read time: 16; Write time: 164820 10:54:27 INFO - TinderboxPrint: CPU usage
12.9% 10:54:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:54:27 INFO - TinderboxPrint: I/O write bytes / time
320,053,248 / 164,820 10:54:27 INFO - TinderboxPrint: CPU idle
8,235.7 (87.1%) 10:54:27 INFO - TinderboxPrint: CPU user
1,183.0 (12.5%) 10:54:27 INFO - TinderboxPrint: Swap in / out
0 / 0 10:54:27 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 111923200; Read time: 0; Write time: 65816 10:54:27 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 208130048; Read time: 16; Write time: 99004 10:54:28 INFO - Running post-run listener: _upload_blobber_files 10:54:28 INFO - Blob upload gear active. 10:54:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:54:28 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 10:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:54:28 INFO - (blobuploader) - INFO - Open directory for files ... 10:54:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:54:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:31 INFO - (blobuploader) - INFO - Done attempting. 10:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:32 INFO - (blobuploader) - INFO - Done attempting. 10:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:33 INFO - (blobuploader) - INFO - Done attempting. 10:54:33 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:33 INFO - Return code: 0 10:54:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441f6ad558f2082d7517918885facff08515fca8adc73e4710f2b84ae585dd50c3948d2550cc434ccec1d5b66e4a0809d476748909fd9df310a5dbc4f2e2c3fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e827544bd2f34aef17ea750d3f4162789d307d7bd0d68d3f3d17d68acb9aada8f2406c363512704be7774a1a6333d870fdbd1f4cf33ed1c6b130579afaee949c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7fc5ed29df0a16cb04e59f9c9c190aa7282ba73afba2f1a464e39cbb2e4290d9c59c5e1b786e9fa9739e38cd5585c0e221a9db615a939251c7b98ed05e5d3afd"} 10:54:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:33 INFO - Contents: 10:54:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441f6ad558f2082d7517918885facff08515fca8adc73e4710f2b84ae585dd50c3948d2550cc434ccec1d5b66e4a0809d476748909fd9df310a5dbc4f2e2c3fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e827544bd2f34aef17ea750d3f4162789d307d7bd0d68d3f3d17d68acb9aada8f2406c363512704be7774a1a6333d870fdbd1f4cf33ed1c6b130579afaee949c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7fc5ed29df0a16cb04e59f9c9c190aa7282ba73afba2f1a464e39cbb2e4290d9c59c5e1b786e9fa9739e38cd5585c0e221a9db615a939251c7b98ed05e5d3afd"} 10:54:33 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:33 INFO - Copying logs to upload dir... 10:54:33 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.785603 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-12-15 10:54:33.236412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 10:54:33.240486) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 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-Beta/sha512/441f6ad558f2082d7517918885facff08515fca8adc73e4710f2b84ae585dd50c3948d2550cc434ccec1d5b66e4a0809d476748909fd9df310a5dbc4f2e2c3fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e827544bd2f34aef17ea750d3f4162789d307d7bd0d68d3f3d17d68acb9aada8f2406c363512704be7774a1a6333d870fdbd1f4cf33ed1c6b130579afaee949c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7fc5ed29df0a16cb04e59f9c9c190aa7282ba73afba2f1a464e39cbb2e4290d9c59c5e1b786e9fa9739e38cd5585c0e221a9db615a939251c7b98ed05e5d3afd"} build_url:https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/Vqo6R_hiT26ocpjfuyI5hQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441f6ad558f2082d7517918885facff08515fca8adc73e4710f2b84ae585dd50c3948d2550cc434ccec1d5b66e4a0809d476748909fd9df310a5dbc4f2e2c3fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e827544bd2f34aef17ea750d3f4162789d307d7bd0d68d3f3d17d68acb9aada8f2406c363512704be7774a1a6333d870fdbd1f4cf33ed1c6b130579afaee949c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7fc5ed29df0a16cb04e59f9c9c190aa7282ba73afba2f1a464e39cbb2e4290d9c59c5e1b786e9fa9739e38cd5585c0e221a9db615a939251c7b98ed05e5d3afd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 10:54:33.266015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:54:33.266356) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1481824709.621116-1564421902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 10:54:33.349906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 10:54:33.350259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 10:54:33.350570) ========= ========= Total master_lag: 0.16 =========