builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1471424884.38 results: success (0) buildid: 20160816233020 builduid: 566c3b74cfd34d1dad7e14486f79b709 revision: 72f11467d2cf3ba94248e265acaad58216660210 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.383950) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.384569) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.384860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.429662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.429917) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 02:08: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-17 02:08:04 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.582986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.583544) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020637 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.633577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:04.633877) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 72f11467d2cf3ba94248e265acaad58216660210 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 72f11467d2cf3ba94248e265acaad58216660210 --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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 02:08:04,971 truncating revision to first 12 chars 2016-08-17 02:08:04,971 Setting DEBUG logging. 2016-08-17 02:08:04,971 attempt 1/10 2016-08-17 02:08:04,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/72f11467d2cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 02:08:05,271 unpacking tar archive at: fx-team-72f11467d2cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:05.292662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:05.292926) ========= script_repo_revision: 72f11467d2cf3ba94248e265acaad58216660210 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:05.293297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:05.293561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 02:08:05.311136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-17 02:08:05.311418) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:08:05 INFO - MultiFileLogger online at 20160817 02:08:05 in /builds/slave/test 02:08:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:08:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:05 INFO - {'append_to_log': False, 02:08:05 INFO - 'base_work_dir': '/builds/slave/test', 02:08:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:05 INFO - 'branch': 'Fx-Team', 02:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:05 INFO - 'config_files': ('talos/linux_config.py',), 02:08:05 INFO - 'default_actions': ('clobber', 02:08:05 INFO - 'read-buildbot-config', 02:08:05 INFO - 'download-and-extract', 02:08:05 INFO - 'populate-webroot', 02:08:05 INFO - 'create-virtualenv', 02:08:05 INFO - 'install', 02:08:05 INFO - 'run-tests'), 02:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:05 INFO - 'download_minidump_stackwalk': True, 02:08:05 INFO - 'download_symbols': 'ondemand', 02:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:05 INFO - 'installer_path': 'installer.exe', 02:08:05 INFO - 'log_level': 'info', 02:08:05 INFO - 'log_name': 'talos', 02:08:05 INFO - 'log_to_console': True, 02:08:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:08:05 INFO - 'opt_config_files': (), 02:08:05 INFO - 'pip_index': False, 02:08:05 INFO - 'sps_profile': False, 02:08:05 INFO - 'sps_profile_interval': 0, 02:08:05 INFO - 'suite': 'dromaeojs', 02:08:05 INFO - 'system_bits': '32', 02:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:05 INFO - 'title': 'talos-linux64-ix-040', 02:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:05 INFO - 'use_talos_json': True, 02:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:05 INFO - 'work_dir': 'build'} 02:08:05 INFO - [mozharness: 2016-08-17 09:08:05.741683Z] Running clobber step. 02:08:05 INFO - Running pre-action listener: _resource_record_pre_action 02:08:05 INFO - Running main action method: clobber 02:08:05 INFO - rmtree: /builds/slave/test/build 02:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:06 INFO - Running post-action listener: _resource_record_post_action 02:08:06 INFO - [mozharness: 2016-08-17 09:08:06.197625Z] Finished clobber step (success) 02:08:06 INFO - [mozharness: 2016-08-17 09:08:06.197725Z] Running read-buildbot-config step. 02:08:06 INFO - Running pre-action listener: _resource_record_pre_action 02:08:06 INFO - Running main action method: read_buildbot_config 02:08:06 INFO - Using buildbot properties: 02:08:06 INFO - { 02:08:06 INFO - "project": "", 02:08:06 INFO - "product": "firefox", 02:08:06 INFO - "script_repo_revision": "production", 02:08:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:08:06 INFO - "repository": "", 02:08:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:08:06 INFO - "buildid": "20160816233020", 02:08:06 INFO - "pgo_build": "True", 02:08:06 INFO - "basedir": "/builds/slave/test", 02:08:06 INFO - "buildnumber": 367, 02:08:06 INFO - "slavename": "talos-linux64-ix-040", 02:08:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:08:06 INFO - "platform": "ubuntu64_hw", 02:08:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:08:06 INFO - "branch": "fx-team", 02:08:06 INFO - "repo_path": "integration/fx-team", 02:08:06 INFO - "revision": "72f11467d2cf3ba94248e265acaad58216660210", 02:08:06 INFO - "stage_platform": "linux64-pgo", 02:08:06 INFO - "builduid": "566c3b74cfd34d1dad7e14486f79b709", 02:08:06 INFO - "slavebuilddir": "test" 02:08:06 INFO - } 02:08:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:08:06 INFO - Running post-action listener: _resource_record_post_action 02:08:06 INFO - [mozharness: 2016-08-17 09:08:06.200116Z] Finished read-buildbot-config step (success) 02:08:06 INFO - [mozharness: 2016-08-17 09:08:06.200202Z] Running download-and-extract step. 02:08:06 INFO - Running pre-action listener: _resource_record_pre_action 02:08:06 INFO - Running main action method: download_and_extract 02:08:06 INFO - mkdir: /builds/slave/test/build/tests 02:08: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')]} 02:08:06 INFO - trying https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:08:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:08:06 INFO - Downloaded 1361 bytes. 02:08:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:08:06 INFO - Using the following test package requirements: 02:08:06 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:08:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:08:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'jsshell-linux-x86_64.zip'], 02:08:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:08:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:08:06 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:08:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:08:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:08:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:08: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')]} 02:08:06 INFO - trying https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:08:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:07 INFO - Downloaded 21902655 bytes. 02:08:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:08:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:08:11 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')]} 02:08:11 INFO - trying https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:08:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:12 INFO - Downloaded 21902655 bytes. 02:08:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:08:17 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')]} 02:08:17 INFO - trying https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:08:18 INFO - Downloaded 14413981 bytes. 02:08:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 02:08: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')]} 02:08:18 INFO - trying https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:08:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:08:19 INFO - Downloaded 59432988 bytes. 02:08:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:08:19 INFO - mkdir: /builds/slave/test/properties 02:08:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:19 INFO - Contents: 02:08:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:08:20 INFO - Running post-action listener: _resource_record_post_action 02:08:20 INFO - Running post-action listener: set_extra_try_arguments 02:08:20 INFO - [mozharness: 2016-08-17 09:08:20.130983Z] Finished download-and-extract step (success) 02:08:20 INFO - [mozharness: 2016-08-17 09:08:20.131278Z] Running populate-webroot step. 02:08:20 INFO - Running pre-action listener: _resource_record_pre_action 02:08:20 INFO - Running main action method: populate_webroot 02:08:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:20 INFO - '--tppagecycles', 02:08:20 INFO - '7'], 02:08:20 INFO - 'tests': ['tsvgm']}}, 02:08:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['damp', 'tps']}, 02:08:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'tests': ['damp', 'tps']}, 02:08:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['dromaeo_dom']}, 02:08:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['basic_compositor_video']}, 02:08:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:08:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['a11yr', 02:08:20 INFO - 'ts_paint', 02:08:20 INFO - 'tpaint', 02:08:20 INFO - 'sessionrestore', 02:08:20 INFO - 'sessionrestore_no_auto_restore', 02:08:20 INFO - 'tabpaint']}, 02:08:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['tsvgx', 02:08:20 INFO - 'tsvgr_opacity', 02:08:20 INFO - 'tart', 02:08:20 INFO - 'tscrollx', 02:08:20 INFO - 'cart']}, 02:08:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:20 INFO - 'tsvgr_opacity', 02:08:20 INFO - 'tart', 02:08:20 INFO - 'tscrollx', 02:08:20 INFO - 'cart']}, 02:08:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'talos_options': ['--disable-e10s'], 02:08:20 INFO - 'tests': ['tp5o']}, 02:08:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'tests': ['tp5o']}, 02:08:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'talos_options': ['--disable-e10s', 02:08:20 INFO - '--xperf_path', 02:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:20 INFO - 'tests': ['tp5n']}, 02:08:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:20 INFO - 'talos_options': ['--xperf_path', 02:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:20 INFO - 'tests': ['tp5n']}}, 02:08:20 INFO - 'talos.zip': {'path': '', 02:08:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:20 INFO - Running post-action listener: _resource_record_post_action 02:08:20 INFO - [mozharness: 2016-08-17 09:08:20.152451Z] Finished populate-webroot step (success) 02:08:20 INFO - [mozharness: 2016-08-17 09:08:20.152543Z] Running create-virtualenv step. 02:08:20 INFO - Running pre-action listener: _resource_record_pre_action 02:08:20 INFO - Running main action method: create_virtualenv 02:08:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:20 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 02:08:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:20 INFO - Using real prefix '/usr' 02:08:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:22 INFO - Installing pip.................done. 02:08:22 INFO - Return code: 0 02:08:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:22 INFO - Using env: {'DISPLAY': ':0', 02:08:22 INFO - 'HOME': '/home/cltbld', 02:08:22 INFO - 'LANG': 'en_US.UTF-8', 02:08:22 INFO - 'LANGUAGE': 'en_US:en', 02:08:22 INFO - 'LOGNAME': 'cltbld', 02:08:22 INFO - 'MAIL': '/var/mail/cltbld', 02:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:22 INFO - 'MOZ_NO_REMOTE': '1', 02:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:22 INFO - 'NO_EM_RESTART': '1', 02:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:22 INFO - 'PWD': '/builds/slave/test', 02:08:22 INFO - 'SHELL': '/bin/bash', 02:08:22 INFO - 'SHLVL': '1', 02:08:22 INFO - 'TERM': 'linux', 02:08:22 INFO - 'TMOUT': '86400', 02:08:22 INFO - 'USER': 'cltbld', 02:08:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:22 INFO - '_': '/tools/buildbot/bin/python'} 02:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08: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 02:08:22 INFO - Cleaning up... 02:08:22 INFO - Return code: 0 02:08:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:22 INFO - Using env: {'DISPLAY': ':0', 02:08:22 INFO - 'HOME': '/home/cltbld', 02:08:22 INFO - 'LANG': 'en_US.UTF-8', 02:08:22 INFO - 'LANGUAGE': 'en_US:en', 02:08:22 INFO - 'LOGNAME': 'cltbld', 02:08:22 INFO - 'MAIL': '/var/mail/cltbld', 02:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:22 INFO - 'MOZ_NO_REMOTE': '1', 02:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:22 INFO - 'NO_EM_RESTART': '1', 02:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:22 INFO - 'PWD': '/builds/slave/test', 02:08:22 INFO - 'SHELL': '/bin/bash', 02:08:22 INFO - 'SHLVL': '1', 02:08:22 INFO - 'TERM': 'linux', 02:08:22 INFO - 'TMOUT': '86400', 02:08:22 INFO - 'USER': 'cltbld', 02:08:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:22 INFO - '_': '/tools/buildbot/bin/python'} 02:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:23 INFO - Downloading/unpacking psutil>=3.1.1 02:08:23 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 02:08:23 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 02:08:23 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 02:08:23 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 02:08:23 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 02:08:23 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 02:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:25 INFO - Installing collected packages: psutil 02:08:25 INFO - Running setup.py install for psutil 02:08:25 INFO - building 'psutil._psutil_linux' extension 02:08: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 02:08: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 02:08:25 INFO - building 'psutil._psutil_posix' extension 02:08: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 02:08: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 02:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:25 INFO - Successfully installed psutil 02:08:25 INFO - Cleaning up... 02:08:25 INFO - Return code: 0 02:08:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:25 INFO - Using env: {'DISPLAY': ':0', 02:08:25 INFO - 'HOME': '/home/cltbld', 02:08:25 INFO - 'LANG': 'en_US.UTF-8', 02:08:25 INFO - 'LANGUAGE': 'en_US:en', 02:08:25 INFO - 'LOGNAME': 'cltbld', 02:08:25 INFO - 'MAIL': '/var/mail/cltbld', 02:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:25 INFO - 'MOZ_NO_REMOTE': '1', 02:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:25 INFO - 'NO_EM_RESTART': '1', 02:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:25 INFO - 'PWD': '/builds/slave/test', 02:08:25 INFO - 'SHELL': '/bin/bash', 02:08:25 INFO - 'SHLVL': '1', 02:08:25 INFO - 'TERM': 'linux', 02:08:25 INFO - 'TMOUT': '86400', 02:08:25 INFO - 'USER': 'cltbld', 02:08:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:25 INFO - '_': '/tools/buildbot/bin/python'} 02:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:08:27 INFO - Installing collected packages: mozsystemmonitor 02:08:27 INFO - Running setup.py install for mozsystemmonitor 02:08:27 INFO - Successfully installed mozsystemmonitor 02:08:27 INFO - Cleaning up... 02:08:28 INFO - Return code: 0 02:08:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:28 INFO - Using env: {'DISPLAY': ':0', 02:08:28 INFO - 'HOME': '/home/cltbld', 02:08:28 INFO - 'LANG': 'en_US.UTF-8', 02:08:28 INFO - 'LANGUAGE': 'en_US:en', 02:08:28 INFO - 'LOGNAME': 'cltbld', 02:08:28 INFO - 'MAIL': '/var/mail/cltbld', 02:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:28 INFO - 'MOZ_NO_REMOTE': '1', 02:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:28 INFO - 'NO_EM_RESTART': '1', 02:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:28 INFO - 'PWD': '/builds/slave/test', 02:08:28 INFO - 'SHELL': '/bin/bash', 02:08:28 INFO - 'SHLVL': '1', 02:08:28 INFO - 'TERM': 'linux', 02:08:28 INFO - 'TMOUT': '86400', 02:08:28 INFO - 'USER': 'cltbld', 02:08:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:28 INFO - '_': '/tools/buildbot/bin/python'} 02:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:30 INFO - warning: no files found matching '*.txt' 02:08:30 INFO - no previously-included directories found matching 'build' 02:08:30 INFO - no previously-included directories found matching 'dist' 02:08:30 INFO - no previously-included directories found matching '.git*' 02:08:30 INFO - Installing collected packages: jsonschema, functools32 02:08:30 INFO - Running setup.py install for functools32 02:08:30 INFO - warning: no files found matching '*.txt' 02:08:30 INFO - no previously-included directories found matching 'build' 02:08:30 INFO - no previously-included directories found matching 'dist' 02:08:30 INFO - no previously-included directories found matching '.git*' 02:08:30 INFO - Successfully installed jsonschema functools32 02:08:30 INFO - Cleaning up... 02:08:30 INFO - Return code: 0 02:08:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:30 INFO - Using env: {'DISPLAY': ':0', 02:08:30 INFO - 'HOME': '/home/cltbld', 02:08:30 INFO - 'LANG': 'en_US.UTF-8', 02:08:30 INFO - 'LANGUAGE': 'en_US:en', 02:08:30 INFO - 'LOGNAME': 'cltbld', 02:08:30 INFO - 'MAIL': '/var/mail/cltbld', 02:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:30 INFO - 'MOZ_NO_REMOTE': '1', 02:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:30 INFO - 'NO_EM_RESTART': '1', 02:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:30 INFO - 'PWD': '/builds/slave/test', 02:08:30 INFO - 'SHELL': '/bin/bash', 02:08:30 INFO - 'SHLVL': '1', 02:08:30 INFO - 'TERM': 'linux', 02:08:30 INFO - 'TMOUT': '86400', 02:08:30 INFO - 'USER': 'cltbld', 02:08:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:30 INFO - '_': '/tools/buildbot/bin/python'} 02:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:08:30 INFO - Cleaning up... 02:08:30 INFO - Return code: 0 02:08:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:30 INFO - Using env: {'DISPLAY': ':0', 02:08:30 INFO - 'HOME': '/home/cltbld', 02:08:30 INFO - 'LANG': 'en_US.UTF-8', 02:08:30 INFO - 'LANGUAGE': 'en_US:en', 02:08:30 INFO - 'LOGNAME': 'cltbld', 02:08:30 INFO - 'MAIL': '/var/mail/cltbld', 02:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:30 INFO - 'MOZ_NO_REMOTE': '1', 02:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:30 INFO - 'NO_EM_RESTART': '1', 02:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:30 INFO - 'PWD': '/builds/slave/test', 02:08:30 INFO - 'SHELL': '/bin/bash', 02:08:30 INFO - 'SHLVL': '1', 02:08:30 INFO - 'TERM': 'linux', 02:08:30 INFO - 'TMOUT': '86400', 02:08:30 INFO - 'USER': 'cltbld', 02:08:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:30 INFO - '_': '/tools/buildbot/bin/python'} 02:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08:32 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 02:08:32 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 02:08:32 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 02:08:32 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 02:08:32 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 02:08:32 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 02:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08:33 INFO - Downloading docopt-0.6.1.tar.gz 02:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:33 INFO - Running setup.py install for blobuploader 02:08:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:33 INFO - Running setup.py install for requests 02:08:34 INFO - Running setup.py install for docopt 02:08:34 INFO - Successfully installed blobuploader requests docopt 02:08:34 INFO - Cleaning up... 02:08:34 INFO - Return code: 0 02:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:34 INFO - Using env: {'DISPLAY': ':0', 02:08:34 INFO - 'HOME': '/home/cltbld', 02:08:34 INFO - 'LANG': 'en_US.UTF-8', 02:08:34 INFO - 'LANGUAGE': 'en_US:en', 02:08:34 INFO - 'LOGNAME': 'cltbld', 02:08:34 INFO - 'MAIL': '/var/mail/cltbld', 02:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:34 INFO - 'MOZ_NO_REMOTE': '1', 02:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:34 INFO - 'NO_EM_RESTART': '1', 02:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:34 INFO - 'PWD': '/builds/slave/test', 02:08:34 INFO - 'SHELL': '/bin/bash', 02:08:34 INFO - 'SHLVL': '1', 02:08:34 INFO - 'TERM': 'linux', 02:08:34 INFO - 'TMOUT': '86400', 02:08:34 INFO - 'USER': 'cltbld', 02:08:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:34 INFO - '_': '/tools/buildbot/bin/python'} 02:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:34 INFO - Running setup.py (path:/tmp/pip-X7WSrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:34 INFO - Running setup.py (path:/tmp/pip-DaHPQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:34 INFO - Running setup.py (path:/tmp/pip-vtP8cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:34 INFO - Running setup.py (path:/tmp/pip-lPs98q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:34 INFO - Running setup.py (path:/tmp/pip-X6M933-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:34 INFO - Running setup.py (path:/tmp/pip-bGuYsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:34 INFO - Running setup.py (path:/tmp/pip-KMYVmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:34 INFO - Running setup.py (path:/tmp/pip-R1RgJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:35 INFO - Running setup.py (path:/tmp/pip-Lf_C1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:35 INFO - Running setup.py (path:/tmp/pip-5nuXtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:35 INFO - Running setup.py (path:/tmp/pip-b9x9g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:35 INFO - Running setup.py (path:/tmp/pip-haFRJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:35 INFO - Running setup.py (path:/tmp/pip-OO63Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:35 INFO - Running setup.py (path:/tmp/pip-irLwtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:35 INFO - Running setup.py (path:/tmp/pip-XYK0Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:35 INFO - Running setup.py (path:/tmp/pip-UO0zwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:35 INFO - Running setup.py (path:/tmp/pip-1Q1YbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:35 INFO - Running setup.py install for manifestparser 02:08:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:35 INFO - Running setup.py install for mozcrash 02:08:35 INFO - Running setup.py install for mozdebug 02:08:35 INFO - Running setup.py install for mozdevice 02:08:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozfile 02:08:36 INFO - Running setup.py install for mozhttpd 02:08:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozinfo 02:08:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozInstall 02:08:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozleak 02:08:36 INFO - Running setup.py install for mozlog 02:08:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for moznetwork 02:08:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozprocess 02:08:36 INFO - Running setup.py install for mozprofile 02:08:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozrunner 02:08:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozscreenshot 02:08:37 INFO - Running setup.py install for moztest 02:08:37 INFO - Running setup.py install for mozversion 02:08:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:08:37 INFO - Cleaning up... 02:08:37 INFO - Return code: 0 02:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:37 INFO - Using env: {'DISPLAY': ':0', 02:08:37 INFO - 'HOME': '/home/cltbld', 02:08:37 INFO - 'LANG': 'en_US.UTF-8', 02:08:37 INFO - 'LANGUAGE': 'en_US:en', 02:08:37 INFO - 'LOGNAME': 'cltbld', 02:08:37 INFO - 'MAIL': '/var/mail/cltbld', 02:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:37 INFO - 'MOZ_NO_REMOTE': '1', 02:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:37 INFO - 'NO_EM_RESTART': '1', 02:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:37 INFO - 'PWD': '/builds/slave/test', 02:08:37 INFO - 'SHELL': '/bin/bash', 02:08:37 INFO - 'SHLVL': '1', 02:08:37 INFO - 'TERM': 'linux', 02:08:37 INFO - 'TMOUT': '86400', 02:08:37 INFO - 'USER': 'cltbld', 02:08:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:37 INFO - '_': '/tools/buildbot/bin/python'} 02:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:37 INFO - Running setup.py (path:/tmp/pip-tKeQio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:37 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)) 02:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:37 INFO - Running setup.py (path:/tmp/pip-0oSF6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:37 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)) 02:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:37 INFO - Running setup.py (path:/tmp/pip-4uxRzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:37 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)) 02:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:37 INFO - Running setup.py (path:/tmp/pip-9gF4sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:37 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)) 02:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:37 INFO - Running setup.py (path:/tmp/pip-1fB8f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:38 INFO - Running setup.py (path:/tmp/pip-MgHi1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:38 INFO - Running setup.py (path:/tmp/pip-fXFiCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:38 INFO - Running setup.py (path:/tmp/pip-nZO056-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:38 INFO - Running setup.py (path:/tmp/pip-XWBR7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:38 INFO - Running setup.py (path:/tmp/pip-QXi9rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:38 INFO - Running setup.py (path:/tmp/pip-Xm6_04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:38 INFO - Running setup.py (path:/tmp/pip-H4Sr1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:38 INFO - Running setup.py (path:/tmp/pip-2wJkXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:38 INFO - Running setup.py (path:/tmp/pip-x032SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08: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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:38 INFO - Running setup.py (path:/tmp/pip-IQIuum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:38 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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:38 INFO - Running setup.py (path:/tmp/pip-UrRcyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:38 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)) 02:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:38 INFO - Running setup.py (path:/tmp/pip-hfB2K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:38 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)) 02:08:38 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)) 02:08:38 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)) 02:08:38 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)) 02:08:38 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)) 02:08:38 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)) 02:08:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:38 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 02:08:38 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 02:08:38 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 02:08:38 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 02:08:38 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 02:08:38 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 02:08:40 INFO - Downloading blessings-1.6.tar.gz 02:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:40 INFO - Installing collected packages: blessings 02:08:40 INFO - Running setup.py install for blessings 02:08:41 INFO - Successfully installed blessings 02:08:41 INFO - Cleaning up... 02:08:41 INFO - Return code: 0 02:08:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:41 INFO - Reading from file tmpfile_stdout 02:08:41 INFO - Current package versions: 02:08:41 INFO - argparse == 1.2.1 02:08:41 INFO - blessings == 1.6 02:08:41 INFO - blobuploader == 1.2.4 02:08:41 INFO - docopt == 0.6.1 02:08:41 INFO - functools32 == 3.2.3-2 02:08:41 INFO - jsonschema == 2.5.1 02:08:41 INFO - manifestparser == 1.1 02:08:41 INFO - mozInstall == 1.12 02:08:41 INFO - mozcrash == 0.17 02:08:41 INFO - mozdebug == 0.1 02:08:41 INFO - mozdevice == 0.48 02:08:41 INFO - mozfile == 1.2 02:08:41 INFO - mozhttpd == 0.7 02:08:41 INFO - mozinfo == 0.9 02:08:41 INFO - mozleak == 0.1 02:08:41 INFO - mozlog == 3.3 02:08:41 INFO - moznetwork == 0.27 02:08:41 INFO - mozprocess == 0.23 02:08:41 INFO - mozprofile == 0.28 02:08:41 INFO - mozrunner == 6.12 02:08:41 INFO - mozscreenshot == 0.1 02:08:41 INFO - mozsystemmonitor == 0.3 02:08:41 INFO - moztest == 0.7 02:08:41 INFO - mozversion == 1.4 02:08:41 INFO - psutil == 3.1.1 02:08:41 INFO - requests == 1.2.3 02:08:41 INFO - wsgiref == 0.1.2 02:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:41 INFO - Using env: {'DISPLAY': ':0', 02:08:41 INFO - 'HOME': '/home/cltbld', 02:08:41 INFO - 'LANG': 'en_US.UTF-8', 02:08:41 INFO - 'LANGUAGE': 'en_US:en', 02:08:41 INFO - 'LOGNAME': 'cltbld', 02:08:41 INFO - 'MAIL': '/var/mail/cltbld', 02:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:41 INFO - 'MOZ_NO_REMOTE': '1', 02:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:41 INFO - 'NO_EM_RESTART': '1', 02:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:41 INFO - 'PWD': '/builds/slave/test', 02:08:41 INFO - 'SHELL': '/bin/bash', 02:08:41 INFO - 'SHLVL': '1', 02:08:41 INFO - 'TERM': 'linux', 02:08:41 INFO - 'TMOUT': '86400', 02:08:41 INFO - 'USER': 'cltbld', 02:08:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:41 INFO - '_': '/tools/buildbot/bin/python'} 02:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08: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)) 02:08:41 INFO - Cleaning up... 02:08:41 INFO - Return code: 0 02:08:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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 0x7f7919881f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1565850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, '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': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', '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 02:08: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 02:08: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 02:08:41 INFO - Using env: {'DISPLAY': ':0', 02:08:41 INFO - 'HOME': '/home/cltbld', 02:08:41 INFO - 'LANG': 'en_US.UTF-8', 02:08:41 INFO - 'LANGUAGE': 'en_US:en', 02:08:41 INFO - 'LOGNAME': 'cltbld', 02:08:41 INFO - 'MAIL': '/var/mail/cltbld', 02:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:41 INFO - 'MOZ_NO_REMOTE': '1', 02:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:41 INFO - 'NO_EM_RESTART': '1', 02:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:41 INFO - 'PWD': '/builds/slave/test', 02:08:41 INFO - 'SHELL': '/bin/bash', 02:08:41 INFO - 'SHLVL': '1', 02:08:41 INFO - 'TERM': 'linux', 02:08:41 INFO - 'TMOUT': '86400', 02:08:41 INFO - 'USER': 'cltbld', 02:08:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:41 INFO - '_': '/tools/buildbot/bin/python'} 02:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:08:41 INFO - Cleaning up... 02:08:41 INFO - Return code: 0 02:08:41 INFO - Running post-action listener: _resource_record_post_action 02:08:41 INFO - Running post-action listener: _start_resource_monitoring 02:08:41 INFO - Starting resource monitoring. 02:08:41 INFO - [mozharness: 2016-08-17 09:08:41.768078Z] Finished create-virtualenv step (success) 02:08:41 INFO - [mozharness: 2016-08-17 09:08:41.768577Z] Running install step. 02:08:41 INFO - Running pre-action listener: _resource_record_pre_action 02:08:41 INFO - Running main action method: install 02:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:41 INFO - Reading from file tmpfile_stdout 02:08:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:42 INFO - Reading from file tmpfile_stdout 02:08:42 INFO - Output received: 02:08:42 INFO - Usage: mozinstall [options] installer 02:08:42 INFO - Options: 02:08:42 INFO - -h, --help show this help message and exit 02:08:42 INFO - -d DEST, --destination=DEST 02:08:42 INFO - Directory to install application into. [default: 02:08:42 INFO - "/builds/slave/test"] 02:08:42 INFO - --app=APP Application being installed. [default: firefox] 02:08:42 INFO - mkdir: /builds/slave/test/build/application 02:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:08:58 INFO - Reading from file tmpfile_stdout 02:08:58 INFO - Output received: 02:08:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:08:58 INFO - Running post-action listener: _resource_record_post_action 02:08:58 INFO - [mozharness: 2016-08-17 09:08:58.975371Z] Finished install step (success) 02:08:58 INFO - [mozharness: 2016-08-17 09:08:58.975618Z] Running run-tests step. 02:08:58 INFO - Running pre-action listener: _resource_record_pre_action 02:08:58 INFO - Running main action method: run_tests 02:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:58 INFO - Python 2.7.3 02:08:58 INFO - Return code: 0 02:08:58 INFO - grabbing minidump binary from tooltool 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:58 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 0x1560370>, '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 0x15638f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1563d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:58 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 02:08:58 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 02:08:58 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 02:08:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:59 INFO - Return code: 0 02:08:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:08:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:08:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 02:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 02:08:59 INFO - Using env: {'DISPLAY': ':0', 02:08:59 INFO - 'HOME': '/home/cltbld', 02:08:59 INFO - 'LANG': 'en_US.UTF-8', 02:08:59 INFO - 'LANGUAGE': 'en_US:en', 02:08:59 INFO - 'LOGNAME': 'cltbld', 02:08:59 INFO - 'MAIL': '/var/mail/cltbld', 02:08:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:59 INFO - 'MOZ_NO_REMOTE': '1', 02:08:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:59 INFO - 'NO_EM_RESTART': '1', 02:08:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:59 INFO - 'PWD': '/builds/slave/test', 02:08:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:59 INFO - 'SHELL': '/bin/bash', 02:08:59 INFO - 'SHLVL': '1', 02:08:59 INFO - 'TERM': 'linux', 02:08:59 INFO - 'TMOUT': '86400', 02:08:59 INFO - 'USER': 'cltbld', 02:08:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690', 02:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:59 INFO - '_': '/tools/buildbot/bin/python'} 02:08:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 02:08:59 INFO - mozversion application_buildid: 20160816233020 02:08:59 INFO - mozversion application_changeset: 72f11467d2cf3ba94248e265acaad58216660210 02:08:59 INFO - mozversion application_display_name: Nightly 02:08:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:59 INFO - mozversion application_name: Firefox 02:08:59 INFO - mozversion application_remotingname: firefox 02:08:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:08:59 INFO - mozversion application_vendor: Mozilla 02:08:59 INFO - mozversion application_version: 51.0a1 02:08:59 INFO - mozversion platform_buildid: 20160816233020 02:08:59 INFO - mozversion platform_changeset: 72f11467d2cf3ba94248e265acaad58216660210 02:08:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:08:59 INFO - mozversion platform_version: 51.0a1 02:08:59 INFO - using testdate: 1471424939 02:08:59 INFO - actual date: 1471424939 02:08:59 INFO - starting webserver on 'localhost:41949' 02:08:59 INFO - SUITE-START | Running 2 tests 02:08:59 INFO - TEST-START | dromaeo_css 02:08:59 INFO - operating with platform_type : linux_ 02:08:59 INFO - Initialising browser for dromaeo_css test... 02:08:59 INFO - TEST-INFO | started process 13928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtnqT7/profile http://localhost:41949/getInfo.html) 02:09:03 INFO - PROCESS | 13928 | __metrics Screen width/height:1600/1200 02:09:03 INFO - PROCESS | 13928 | colorDepth:24 02:09:03 INFO - PROCESS | 13928 | Browser inner width/height: 1024/697 02:09:03 INFO - PROCESS | 13928 | __metrics 02:09:03 INFO - PROCESS | 13928 | 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" 02:09:03 INFO - PROCESS | 13928 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:04 INFO - PROCESS | 13928 | console.error: PushService: 02:09:04 INFO - PROCESS | 13928 | stateChangeProcessEnqueue: Error transitioning state 02:09:04 INFO - PROCESS | 13928 | UnknownError 02:09:04 INFO - TEST-INFO | 13928: exit 0 02:09:04 INFO - Browser initialized. 02:09:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:04 INFO - TEST-INFO | started process 14011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtnqT7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:16 INFO - PROCESS | 14011 | RSS: Main: 154890240 02:09:16 INFO - PROCESS | 14011 | 02:10:08 INFO - PROCESS | 14011 | 1471425008333 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] 02:12:18 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41949/tests/dromaeo/cssquery-ext.html) 02:12:19 INFO - PROCESS | 14011 | RSS: Main: 273166336 02:12:19 INFO - PROCESS | 14011 | 02:15:21 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-ext.html (next: http://localhost:41949/tests/dromaeo/cssquery-jquery.html) 02:15:22 INFO - PROCESS | 14011 | RSS: Main: 243277824 02:15:22 INFO - PROCESS | 14011 | 02:18:24 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41949/tests/dromaeo/cssquery-mootools.html) 02:18:24 INFO - PROCESS | 14011 | RSS: Main: 184483840 02:18:24 INFO - PROCESS | 14011 | 02:21:26 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41949/tests/dromaeo/cssquery-prototype.html) 02:21:27 INFO - PROCESS | 14011 | RSS: Main: 185491456 02:21:27 INFO - PROCESS | 14011 | 02:24:30 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41949/tests/dromaeo/cssquery-yui.html) 02:24:31 INFO - PROCESS | 14011 | RSS: Main: 184963072 02:24:31 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | Cycle 1(1): loaded http://localhost:41949/tests/dromaeo/cssquery-yui.html (next: http://localhost:41949/tests/dromaeo/cssquery-dojo.html) 02:27:33 INFO - PROCESS | 14011 | RSS: Main: 290500608 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | __start_tp_report 02:27:33 INFO - PROCESS | 14011 | _x_x_mozilla_page_load 02:27:33 INFO - PROCESS | 14011 | _x_x_mozilla_page_load_details 02:27:33 INFO - PROCESS | 14011 | |i|pagename|runs| 02:27:33 INFO - PROCESS | 14011 | |0;dojo.html;3059.403416333814;3079.1840162356993;3086.1667349815543;3104.28601421673;3109.1760683418884;5104.795808167678;5136.818531737693;5272.710000949946;5376.408595054546;5428.131498960167;5285.4450282720245;5374.355077390718;5392.514673679368;5414.187871819229;5472.808451704191;4763.571278584926;4827.25177597473;4857.587105096053;4865.34317867087;5021.322121513604;4932.556069953704;4951.0592987332475;4978.676386034915;4997;5017.473165317644;4716.716996980175;4788.018456216502;4791.377120974286;4857.125717370872;4945.876353091166;4811.254255590354;4815.711057336571;4816.397950256218;4861.440934292566;4918.262260660894;4813.951860481386;4816.566509014206;4817.181079216542;4828.106800241966;4912.680675756064;5218.060749065166;5258.553022993012;5320.946790532123;5337.172738225581;5397.946020539784;5739.253896993406;5742.454466825645;5764.654120752768;5780.653160810365;5794.97102514489;5794.362620111784;5794.5943783935145;5795.855103622401;5820.156077368758;5834.766609335621;5235.188545775411;5292.047431462335;5361;5374.35507739066;5476.616636835463;5920.230370051866;5935.792247271324;5948;5950.851228719317;5954.612950158225;5687.971560142256;5691;5736.311642602915;5739.253896993448;5739.741711622987;5521.696306703089;5659.915101273484;5726.255586773693;5740.741666625012;5846.853828654318;5766.077427611646;5766.3368712598585;5766.452187042224;5772.480476757112;5780.104083867007;5705.942940570624;5711.428857114255;5771.971140144273;5777.826665200051;5781.075027995501;4308.6983911126545;4326.3510473428605;4332.805023773938;4394.692371534026;4397.1205758848355;3943.921121577552;3968.6031396860662;3968.642822145963;3973.1854969731135;3973.3642617181113;5383.730813459311;5399.190121481731;5409.6754194747655;5412.052890744104;5551.694656793915;5839.824805255849;5845.240118784531;5847.386024467455;5875.059990401601;5889.646621202742;5445.945540544623;5493.835184944458;5507.531859791882;5510.035743744908;5513.117901135799;4808.903821923542;4844.975775121102;4893.143699852511;4975;5023.09584274834;5951.315598706205;5988.820335389945;6020.729067191987;6027.126066720301;6035.426634469718;5710.971445142748;5746.166805813217;5759.337676167294;5778.624389414675;5782.306123265067;5760.423957604206;5912.704364781658;5990.400959903975;5995;5997;5665.150227465913;5777.566682498746;5804.390538993345;5806;5822.446867547576;5842.737076831638;5852.648841069549;5867.090600956688;5868.530517558671;5869.207656966255;5405.567554595545;5656.858578535405;5683.5453163747625;5708.229389032594;5721.8569535761935;5522.2544956430365;5606.887862242814;5641.464060914371;5731.369549349652;5775;5615.129654903497;5649.4633009864;5669.631473954345;5670.9432905672065;5673.77304907799;5472.808451704172;5749.281339832521;5762.683052432157;5791.594588378773;5811.53507719373;5426.891462170814;5465.781368745205;5486.094794359045;5578;5583.609147359808 02:27:33 INFO - PROCESS | 14011 | |1;ext.html;589.764094362255;603.5473394953784;622.4833388287722;631.1637080867849;639.8048595178469;31834.044978650618;32290.515642265356;35649.643503564956;35833.64166358336;42272.15455690892;45647.31529027067;45760.313595296095;45778.08443831121;45786.542134578725;45872.77063614677;8755.693550725742;8912.465252084896;8914.375993680413;8985.595648195815;9004.279657627374;8904;8996.77508062297;9001.099890011012;9001.50491722955;9002.234810041155;9004.459732416077;9048.276137908984;9051.275897928183;9051.456912585232;9052.592633331516;8956;8957.14907083826;8963.238124759404;9002.459852408876;9004.909950900472;8899.110088991114;8906.153915378029;8957.865632015524;8968.327375446803;8974;43676;43755.34366984498;44000.11999759987;44069.55930440719;44124.55875441236;3380.746444016684;3800.8289626966853;3804.068003339172;4029.7985100744845;4170.561156401037;32925.83537082299;33034.6696533034;33726.1568460788;33801.154971125674;34098.48852267218;4413.6910416270875;4477.3731677565165;4482.125985432842;4521.819127234907;4603.033362993775;344529;345740;347091;348099;348302.99999999744;59570;59780;59896.70568118795;59978.70010650006;60108;33937;34390.48414273788;34544.48183277253;62692;62692.37307626956;17565.121743912754;17739.29042838272;17741.46775596734;17746.29014839392;17799.377021804175;13382.598522044354;13429;13471.865281347256;13482.528111516245;13483.460661573623;19441.533686616192;19484.123214455383;19497.707534386995;19707.507312317306;19807.801921980597;6908.930910690829;6966.1988871280455;7135.785926422215;7247.601381924045;7307.8538429232185;963.6964356227766;989.1345073061071;1064.1061508332882;1093.8413929980109;1139.2310190621463;32551.348973020406;33029;33038.83480582582;33059;33239.537807579705;1069.2461814420815;1089.4334945828284;1108.6396921000546;1141.5433826469311;1163.743976325207;15718.21408929549;16556.42052528156;16653.666926661397;16805.495835124966;16980.40568580094;537760;543443;545717;548824;549465;57891.42108578944;58367.416325837046;58454.415455845745;58455;58566;1287.0668765145383;1383.7163381506766;1406.5709958462767;1417.2346932656455;1442.048248156212;29445.558316625695;33638.663613363555;33674;34179;34370;50461.24308135454;51078.744606276734;51114.74442627763;51118;51120.74439627927;427788;429562;431088;432312;433853;28936.421271574873;29311.70688293175;37034.25931481301;45011.774941125084;45518.77240613908;45962;50788.74605626948;50841.237381438565;50940;51033;41848.13746444025;44020.77989610031;44026;44570.3314450277;45327.32009019933;42696.35955460733;43018.35472467853;43041.569584303754;44485.555144449434;45528.317075243234;35289.63965483166;36941.44587831131;37206.6279337214;42880.35679464873;44663.55336446594;30455.543166852956;38681.6131838678;39287;40083.198336033696;40331.59668403278;27991.562228564337;28927;30126.246843829078;30194.69805301919;31173.688263117077 02:27:33 INFO - PROCESS | 14011 | |2;jquery.html;390.12611749680724;394.8381163722874;401.19560281635324;404.07668477528847;423.62720805690986;13700.931495342535;18824.623507529843;20461.795382046173;20749.273775417863;20759.896200518997;18188.09059547024;18522.259109635597;19944.800551994475;20609.587808243825;20965.790342096574;5792.594518383715;5921.674307913063;5932.406759324076;5933.3473317934995;5936.050231962887;5809.2738407699035;5888.440598143191;5891.64650120992;5898.203742494751;5909.025010873201;4167.45823043004;5299.708516031636;6481.935180648204;6506.219253689564;6628.171478565179;5628.634138780966;5885.882282354329;6610.966945165267;6654.767083152091;6656.866862662744;5794.362620111827;5800.100984347433;5805.767769289223;5808.680522571257;5812.82561523155;14894;23551.646725299135;23554.76445235543;23778.64332035021;24431.87784061086;2534.746525347469;2643.5638119710225;2656.495265899473;3031.090672798152;3053.328267781085;10297.22770792186;10436.37381757097;10838.349699018085;10991.505382257817;11199.160062995308;2001.6497113005166;2005.2179649936536;2008.8794672319707;2012.8892910889895;2020.8181263686338;61449.53400753529;62254;74749.6262518684;79040.60479697623;79416.20583794145;11192.888071119347;11402.429878506042;11462.140339474572;11504.712382190512;11741.706457338634;16199.43301984425;16215.83784162167;16237.269322880498;16249.593760155854;16250;8437.282830959315;8673.089325620846;8737.30101591871;8884.644614215358;8908.643654253887;7491.887621685679;7887.487313324616;7900.644470998819;7908.922720948723;8091.0695270043525;4842.709437433765;4879.829205977845;4892.48628893961;5024;5037.269595908573;1931.4785008047747;1980.1188471130208;2005.488600406916;2034.2269937423684;2039.8878061706453;878.5914549734404;953.4898829126384;959.3859929645033;1021.3412349034979;1028.7788125552893;17479.912600436917;20149.294774682814;20801;20970;21199.470013249484;974.4932635029745;978.2418625565244;1013.1489548778914;1014.898510148994;1026.4559783314855;10335.984483025737;11251.381174035343;11403.714907127222;11521.07831373488;11530.866789643942;529734;535687;536301;539444;546274;93509;93574.53212733893;94464.52767736117;96224.51887740516;96455;937.5921474158763;976.1653786012856;992.8163289791412;999.0359303272231;1015.5328548867603;17679.292828286725;17898;18565.25738970426;18576.721349180043;18868.622627547098;44696.762107843744;44780.776096120615;44996.55003449923;45115.097698045196;45974.310385343575;61415.692921536895;61577.69211153915;61952.831650892;63172.36827631665;64023.359766401736;6016.729247183975;7197.928020719935;8149.348052155695;8300.667973281243;8634.150730258874;7569.924300756922;10877.401742904216;11489.712757181138;13583.592492225249;13829.239391833546;11885.643430697093;11916.702082448008;12092.818607720716;12173.513059477522;12249.87750122523;11780.823287650863;11794.410279486163;11828.17202795796;12205.328706921204;12573.497060117494;11585.362805045466;11752.471138798946;11780.234284771463;12069.939650301692;12100.515979361078;8126.878096828671;8266.586670666322;8285.212904774036;8411.62147703367;8515.531645759544;11445.370504622326;11712.238704484182;11823.645290641294;11827.645170644895;12320.568780092653 02:27:33 INFO - PROCESS | 14011 | |3;mootools.html;1320.86791320868;1443.9566812995606;1494.7160039592477;1573.5436723350228;1721.819208983056;8272.66909323627;8687.826243475134;8719.869201961976;8962.955185224066;8969.147930946567;8740.606672699729;8853.424527405714;8856.158664926837;8864.867026994583;8872.512011839346;2078.2310545098335;2346.507233480967;2369.455025344172;2376.192094687806;2378.583747844129;2438.8414753041084;2448.338948483908;2453.1414005098163;2459.86470744109;2465.359006658273;2335.5562443135836;2343.379004563792;2349.3656712687566;2350.788429041386;2371.833971621987;2207.0950910126853;2211.8341124415733;2215.091812356926;2281.885905704708;2353.8940747666225;2413.3001429585397;2419.9395015124765;2421.9515609687883;2428.138011006085;2429.9149529766373;8681.175288347597;8716.825663486758;8732.8690069649;8736.213740763298;8759.868601970975;5227.242049902781;5236.345456817898;5263.6578622389425;5341.946580534183;5389.245505629176;3440.7591468597207;3528.2414280929725;3589.5333606631234;3600.6219346968714;3601.8019008954498;1146.2549342927082;1174.2250114924195;1235.234154824015;1246.1588427811191;1272.389253158489;12524.812127817999;12610.180338278074;12665.810012849815;12671;12681.556145534954;4333.674974376871;4435.26818075014;4637.907241855144;4639.30410438437;4707.7881495332795;9774.364666296668;9774.657886973922;9780.755481112887;9815.705528834147;9824.852627210597;5289.471052894757;5291.894162116813;5298.443663415363;5298.841034768963;5300.628955973045;4307.138572285556;4776.068666610047;4815.2054910940005;4945.901081978341;4954.256861470808;3652.7625704329134;3714.7028237740915;3806.9619303807162;3822.7515211511163;3832.0994566276904;1124.2355198465123;1143.1540659911773;1145.3929417408788;1146.1804809561038;1150.3960420779158;872.9825403491894;873.4104479476329;893.097971049245;897.6588896219395;941.9764505887271;5618.91571626426;5662.8301150965535;5713.8285851424525;5737.569682273846;5848.824535263949;928.8374534456443;937.3204426790522;944.7071407863584;947.4788866123605;958.9808203836023;3744.719146064056;3884.7280690351404;3889.980550097288;3918.529776426847;3926.7251292409255;11103.111751059896;11370.31778093317;11381.430928453545;11411.771764564663;11443;11301.039411649937;11317;11319.320840749417;11319.717007074725;11337;7856.685732570748;8096.392770542115;8137.877931831027;8170.3872209584515;8306.584670766437;5682.602217844711;5849.356570777126;5881.794137205348;5974.2233509643465;6000.609960352563;10394.844077338998;10482.63310784119;10504.212184086071;10576.206784491347;10665.733356665834;10215.387076775418;10383.740406489596;10501.632442864464;10625.840612390975;10637.680869573926;7132.465065120241;7330.560166390033;7344.48588598793;7969.362451004022;8171.101178870201;8255.917440825515;8366.33069354438;8622.52576108295;8631.13688631157;8868.379213455255;7504.774856754306;7675.385969122569;7763.4953728007495;7769.300762931363;7797;7660.846783064419;7865.646045927832;7881.290683838482;7883.881741773993;8100.554469504234;7093.361597456254;7213;7213.963930180315;7217.6752046157;7230.6384680764695;4948.851534453972;4949.737816856678;4983.401991760867;5015.452450743724;5227.686338819683;4957.603391728725;5103.157978933435;5105.157648987875;5106.029854327666;5138.665986710852 02:27:33 INFO - PROCESS | 14011 | |4;prototype.html;328.5859816631045;334.9430596798544;338.37569683933134;345.2921510902649;346.42493460855;5243.501867322603;5250.188684903707;5264.263003179553;5269.8155564555245;5327.706976116312;5202.583793296537;5223.138182199932;5268.236105764662;5270.525652691266;5273.314469119019;3947.1316310411735;3962.48487696599;4057.1337184894837;4059.3302105152616;4092.6112019358116;4082.755034697913;4088.121053973395;4099.7745124018165;4105.2815757242515;4110.321796903522;4025.9798701006453;4036.636702696757;4044.0992733415246;4067.779666100158;4071.6742660587083;3854.7879866607327;3920.3335432976464;4059.634632883025;4091.8772436826944;4094.9385759213637;3671.687906527948;3677.9816100919325;3679.632036796326;3687.631236876318;3692.132348898007;5086.237064440364;5118.488151184889;5132.28148059272;5135.229715542661;5136.74316284188;4413.933790993137;4636.53634636537;4658.114958157939;4660.440747110369;4672.15901137795;5415.729213539307;5422.105352616813;5446.786396026363;5447.945520544823;5448.891022179534;3946.605339466059;3951.7431366961055;3954.980225098856;3956.8219430125714;3976.1848820991627;5474.370447398521;5585.5531557475715;5587.580931430159;5596.496315331639;5677;4022.7988600569856;4024.3561030235023;4026.7986600670433;4031.737937034083;4049.5545489996075;4058.350663893763;4062.5734297898885;4063.674906007512;4068.6745060395097;4080.7959602019782;4447.710898791633;4608.792604332813;4660.790264438108;4663.743494107789;4666.696664716783;5474.863128421821;5484.314460692413;5486;5497.532709719639;5528.861778455571;1390.2978995607357;1398.5664444022386;1421.3796272249645;1422.3315041930275;1429.3639330497829;895.3642913531336;923.3536524432924;944.1125342178331;946.7159852044359;960.2222200018008;5234.581233501311;5235.790568377299;5244.370675518962;5257.2902658140665;5275.419703832576;5520.944790552043;5523.674318163692;5530.86172845674;5535;5544.61187716856;4993.675411098267;5137.5889928806355;5240.6069544784295;5253.1632918224495;5253.264542963988;2888.00363874463;2898.8984186009184;2901.6953219911607;2902.332463533357;2923.2399576110365;5688.075228092685;5721.456461636138;5723.942760572424;5729.570282228766;5758.395368486333;5414.566834653218;5618.550515958714;5621.297337832771;5638.85902852432;5651.689157096317;5684.37471878093;5700.515456186187;5714;5736.512396446349;5750.137479378127;5324.866878328073;5532.585056120726;5533.363663178786;5547.667139971614;5582.972085139549;5418.701971391612;5483.670979741229;5488.4237155098135;5511.622094476381;5511.641743286674;5615.494605485526;5686.692060825951;5727;5748.540116790563;5781.479666830005;3819.2361527694015;4030.4357389966017;4052.594740525924;4053.108316170438;4060.7563546187325;5507.752151153128;5518.503334699896;5534.335879694462;5536.944630553643;5540.196671482693;5444.782208711607;5486.835394938158;5494.697791621499;5497.340319161726;5504.366997795145;5180.922286165786;5360.678359298455;5434.83695489136;5441.374241962225;5499.4225606310765;5383.08487557124;5405.162244836774;5434.266374039454;5440.347158341025;5455.509004189642;5264.710440925633;5297.807993201653;5450.400455949922;5474.09677403224;5487.2317875496665;5336.813211537577;5376.462353764592;5376.7580458878665;5380.488853558905;5390.703511306759 02:27:33 INFO - PROCESS | 14011 | |5;yui.html;731.5500966905355;736.6390468670346;742.8885667149926;749.9962500187498;784.7841843493038;15699.843001569996;16829.326826926925;17306.82693173068;17373.913130434346;17626.206820693067;16213.594660133473;16345.91827040863;16353.345866165339;16354.345826166938;16362.427315043977;671.7715976567966;801.2908575910303;819.6557445872718;821.3306155483263;823.5593957232882;797.9401544884128;815.0871024452591;816.5957850863831;829.5437509369852;832.1013305629905;854.2269246332079;856.3577317012241;857.01443340159;857.0358346859783;858.4205661178711;631.28664608992;842.6292431330195;848.0205362805968;850.132864478235;851.9616617252238;601.7653115285042;615.7629312714593;616.3897741236188;622.0451606783565;622.0855342646303;13883.097598656055;13915.721685566232;13930.37313320903;13941.58175254744;13976.371063302075;13183;13248.40382182804;13931.373088211054;14181.361838717283;14464.566063018126;12265.448054837465;12365.75268494625;12553.309567973758;12589.30758808265;12724.363781810966;3918.314294998364;3980.900477488057;4004.279229738646;4058.0666446717123;4120.175964807021;82256.17743822605;83406.16593834106;83649.58175209085;83935.58032209861;84561.15438845594;10599.364038157735;11205.94397028026;11340.773184536429;11615.128865335133;11665.88334116648;18836.152373143243;19921.60156796856;20101.49746256355;20128;20130.19479220815;8209.8358032839;8283.337333013344;8355.540445275568;8542.359323050796;8846.823063538694;4208.85269015583;4348.652107831366;4397.2964325707735;4429.7785110744335;4539.865033741565;3625.220577575834;3745.7377983541437;3752.437134429803;3753.0617345663586;3757.3236817373136;643.112504743451;643.8197304754676;656.153561905137;660.3858411677186;665.9400653941168;630.4357599948021;672.9966350168315;696.7039008421502;741.9666115024837;794.89666343375;10333.948330258301;10619.185915732338;10624.575016999388;10915.836262456069;10987.505562249718;646.6178815095042;708.1042481261209;734.2657342657343;766.9079710434784;796.38678217772;4901.730404827768;5131.153359695683;5148.639595228373;5177.974110129425;5213.530782229617;131459;133072.3346383262;135106.32446837702;136278;136345;112532.4373378128;113657.4317128409;114978;117234;118313.40843295901;82421;93118;94571;94858.52570737102;98264;9498.810023799348;9607;9742.853857192289;9765.560549775419;9802.50987450639;42008.78995605002;56447.43552564586;56857.431425685216;57393.71303143458;59505.70247148736;82032.17967820246;85337;90336.54831726062;91827;93234.53382733042;12156.817647735468;12548.560800371943;12578.371081446074;12829.871701282867;13373.866261337262;13734.244616545786;13768.586942391745;14328.283585820458;14465.566033019026;14700;12267.754644906874;13443.798343024668;13694.246816425193;13710.794338085136;14369.856301436852;13937.512187073404;14512.709745805236;14597.562073137822;15321.19478300571;15343.386264549294;14405.351759171072;14551.27243637835;14733.189674567573;14826.481073162387;15012.324445399765;11745.354005529778;12649.87350126487;12732.23606583608;12737.93631031839;12753.362331883554;10535.4732263385;11460.197786155222;11602;11956.521739130338;12384 02:27:33 INFO - PROCESS | 14011 | __end_tp_report 02:27:33 INFO - PROCESS | 14011 | __start_cc_report 02:27:33 INFO - PROCESS | 14011 | _x_x_mozilla_cycle_collect,1097 02:27:33 INFO - PROCESS | 14011 | __end_cc_report 02:27:33 INFO - PROCESS | 14011 | __startTimestamp1471426053926__endTimestamp 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | ------- Summary: start ------- 02:27:33 INFO - PROCESS | 14011 | Number of tests: 6 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#0] dojo.html Cycles:165 Average:5354.55 Median:5578.00 stddev:628.36 (11.3%) stddev-sans-first:603.94 02:27:33 INFO - PROCESS | 14011 | Values: 3059.4 3079.2 3086.2 3104.3 3109.2 5104.8 5136.8 5272.7 5376.4 5428.1 5285.4 5374.4 5392.5 5414.2 5472.8 4763.6 4827.3 4857.6 4865.3 5021.3 4932.6 4951.1 4978.7 4997.0 5017.5 4716.7 4788.0 4791.4 4857.1 4945.9 4811.3 4815.7 4816.4 4861.4 4918.3 4814.0 4816.6 4817.2 4828.1 4912.7 5218.1 5258.6 5320.9 5337.2 5397.9 5739.3 5742.5 5764.7 5780.7 5795.0 5794.4 5794.6 5795.9 5820.2 5834.8 5235.2 5292.0 5361.0 5374.4 5476.6 5920.2 5935.8 5948.0 5950.9 5954.6 5688.0 5691.0 5736.3 5739.3 5739.7 5521.7 5659.9 5726.3 5740.7 5846.9 5766.1 5766.3 5766.5 5772.5 5780.1 5705.9 5711.4 5772.0 5777.8 5781.1 4308.7 4326.4 4332.8 4394.7 4397.1 3943.9 3968.6 3968.6 3973.2 3973.4 5383.7 5399.2 5409.7 5412.1 5551.7 5839.8 5845.2 5847.4 5875.1 5889.6 5445.9 5493.8 5507.5 5510.0 5513.1 4808.9 4845.0 4893.1 4975.0 5023.1 5951.3 5988.8 6020.7 6027.1 6035.4 5711.0 5746.2 5759.3 5778.6 5782.3 5760.4 5912.7 5990.4 5995.0 5997.0 5665.2 5777.6 5804.4 5806.0 5822.4 5842.7 5852.6 5867.1 5868.5 5869.2 5405.6 5656.9 5683.5 5708.2 5721.9 5522.3 5606.9 5641.5 5731.4 5775.0 5615.1 5649.5 5669.6 5670.9 5673.8 5472.8 5749.3 5762.7 5791.6 5811.5 5426.9 5465.8 5486.1 5578.0 5583.6 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#1] ext.html Cycles:180 Average:60438.85 Median:433082.50 stddev:118805.72 (27.4%) stddev-sans-first:119054.02 02:27:33 INFO - PROCESS | 14011 | Values: 589.8 603.5 622.5 631.2 639.8 31834.0 32290.5 35649.6 35833.6 42272.2 45647.3 45760.3 45778.1 45786.5 45872.8 8755.7 8912.5 8914.4 8985.6 9004.3 8904.0 8996.8 9001.1 9001.5 9002.2 9004.5 9048.3 9051.3 9051.5 9052.6 8956.0 8957.1 8963.2 9002.5 9004.9 8899.1 8906.2 8957.9 8968.3 8974.0 43676.0 43755.3 44000.1 44069.6 44124.6 3380.7 3800.8 3804.1 4029.8 4170.6 32925.8 33034.7 33726.2 33801.2 34098.5 4413.7 4477.4 4482.1 4521.8 4603.0 344529.0 345740.0 347091.0 348099.0 348303.0 59570.0 59780.0 59896.7 59978.7 60108.0 33937.0 34390.5 34544.5 62692.0 62692.4 17565.1 17739.3 17741.5 17746.3 17799.4 13382.6 13429.0 13471.9 13482.5 13483.5 19441.5 19484.1 19497.7 19707.5 19807.8 6908.9 6966.2 7135.8 7247.6 7307.9 963.7 989.1 1064.1 1093.8 1139.2 32551.3 33029.0 33038.8 33059.0 33239.5 1069.2 1089.4 1108.6 1141.5 1163.7 15718.2 16556.4 16653.7 16805.5 16980.4 537760.0 543443.0 545717.0 548824.0 549465.0 57891.4 58367.4 58454.4 58455.0 58566.0 1287.1 1383.7 1406.6 1417.2 1442.0 29445.6 33638.7 33674.0 34179.0 34370.0 50461.2 51078.7 51114.7 51118.0 51120.7 427788.0 429562.0 431088.0 432312.0 433853.0 28936.4 29311.7 37034.3 45011.8 45518.8 45962.0 50788.7 50841.2 50940.0 51033.0 41848.1 44020.8 44026.0 44570.3 45327.3 42696.4 43018.4 43041.6 44485.6 45528.3 35289.6 36941.4 37206.6 42880.4 44663.6 30455.5 38681.6 39287.0 40083.2 40331.6 27991.6 28927.0 30126.2 30194.7 31173.7 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#2] jquery.html Cycles:180 Average:30459.11 Median:392.48 stddev:88348.84 (22510.3%) stddev-sans-first:88567.83 02:27:33 INFO - PROCESS | 14011 | Values: 390.1 394.8 401.2 404.1 423.6 13700.9 18824.6 20461.8 20749.3 20759.9 18188.1 18522.3 19944.8 20609.6 20965.8 5792.6 5921.7 5932.4 5933.3 5936.1 5809.3 5888.4 5891.6 5898.2 5909.0 4167.5 5299.7 6481.9 6506.2 6628.2 5628.6 5885.9 6611.0 6654.8 6656.9 5794.4 5800.1 5805.8 5808.7 5812.8 14894.0 23551.6 23554.8 23778.6 24431.9 2534.7 2643.6 2656.5 3031.1 3053.3 10297.2 10436.4 10838.3 10991.5 11199.2 2001.6 2005.2 2008.9 2012.9 2020.8 61449.5 62254.0 74749.6 79040.6 79416.2 11192.9 11402.4 11462.1 11504.7 11741.7 16199.4 16215.8 16237.3 16249.6 16250.0 8437.3 8673.1 8737.3 8884.6 8908.6 7491.9 7887.5 7900.6 7908.9 8091.1 4842.7 4879.8 4892.5 5024.0 5037.3 1931.5 1980.1 2005.5 2034.2 2039.9 878.6 953.5 959.4 1021.3 1028.8 17479.9 20149.3 20801.0 20970.0 21199.5 974.5 978.2 1013.1 1014.9 1026.5 10336.0 11251.4 11403.7 11521.1 11530.9 529734.0 535687.0 536301.0 539444.0 546274.0 93509.0 93574.5 94464.5 96224.5 96455.0 937.6 976.2 992.8 999.0 1015.5 17679.3 17898.0 18565.3 18576.7 18868.6 44696.8 44780.8 44996.6 45115.1 45974.3 61415.7 61577.7 61952.8 63172.4 64023.4 6016.7 7197.9 8149.3 8300.7 8634.2 7569.9 10877.4 11489.7 13583.6 13829.2 11885.6 11916.7 12092.8 12173.5 12249.9 11780.8 11794.4 11828.2 12205.3 12573.5 11585.4 11752.5 11780.2 12069.9 12100.5 8126.9 8266.6 8285.2 8411.6 8515.5 11445.4 11712.2 11823.6 11827.6 12320.6 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#3] mootools.html Cycles:180 Average:5824.49 Median:4952.00 stddev:3367.58 (68.0%) stddev-sans-first:3360.02 02:27:33 INFO - PROCESS | 14011 | Values: 1320.9 1444.0 1494.7 1573.5 1721.8 8272.7 8687.8 8719.9 8963.0 8969.1 8740.6 8853.4 8856.2 8864.9 8872.5 2078.2 2346.5 2369.5 2376.2 2378.6 2438.8 2448.3 2453.1 2459.9 2465.4 2335.6 2343.4 2349.4 2350.8 2371.8 2207.1 2211.8 2215.1 2281.9 2353.9 2413.3 2419.9 2422.0 2428.1 2429.9 8681.2 8716.8 8732.9 8736.2 8759.9 5227.2 5236.3 5263.7 5341.9 5389.2 3440.8 3528.2 3589.5 3600.6 3601.8 1146.3 1174.2 1235.2 1246.2 1272.4 12524.8 12610.2 12665.8 12671.0 12681.6 4333.7 4435.3 4637.9 4639.3 4707.8 9774.4 9774.7 9780.8 9815.7 9824.9 5289.5 5291.9 5298.4 5298.8 5300.6 4307.1 4776.1 4815.2 4945.9 4954.3 3652.8 3714.7 3807.0 3822.8 3832.1 1124.2 1143.2 1145.4 1146.2 1150.4 873.0 873.4 893.1 897.7 942.0 5618.9 5662.8 5713.8 5737.6 5848.8 928.8 937.3 944.7 947.5 959.0 3744.7 3884.7 3890.0 3918.5 3926.7 11103.1 11370.3 11381.4 11411.8 11443.0 11301.0 11317.0 11319.3 11319.7 11337.0 7856.7 8096.4 8137.9 8170.4 8306.6 5682.6 5849.4 5881.8 5974.2 6000.6 10394.8 10482.6 10504.2 10576.2 10665.7 10215.4 10383.7 10501.6 10625.8 10637.7 7132.5 7330.6 7344.5 7969.4 8171.1 8255.9 8366.3 8622.5 8631.1 8868.4 7504.8 7675.4 7763.5 7769.3 7797.0 7660.8 7865.6 7881.3 7883.9 8100.6 7093.4 7213.0 7214.0 7217.7 7230.6 4948.9 4949.7 4983.4 5015.5 5227.7 4957.6 5103.2 5105.2 5106.0 5138.7 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#4] prototype.html Cycles:180 Average:4587.46 Median:5266.47 stddev:1336.19 (25.4%) stddev-sans-first:1301.14 02:27:33 INFO - PROCESS | 14011 | Values: 328.6 334.9 338.4 345.3 346.4 5243.5 5250.2 5264.3 5269.8 5327.7 5202.6 5223.1 5268.2 5270.5 5273.3 3947.1 3962.5 4057.1 4059.3 4092.6 4082.8 4088.1 4099.8 4105.3 4110.3 4026.0 4036.6 4044.1 4067.8 4071.7 3854.8 3920.3 4059.6 4091.9 4094.9 3671.7 3678.0 3679.6 3687.6 3692.1 5086.2 5118.5 5132.3 5135.2 5136.7 4413.9 4636.5 4658.1 4660.4 4672.2 5415.7 5422.1 5446.8 5447.9 5448.9 3946.6 3951.7 3955.0 3956.8 3976.2 5474.4 5585.6 5587.6 5596.5 5677.0 4022.8 4024.4 4026.8 4031.7 4049.6 4058.4 4062.6 4063.7 4068.7 4080.8 4447.7 4608.8 4660.8 4663.7 4666.7 5474.9 5484.3 5486.0 5497.5 5528.9 1390.3 1398.6 1421.4 1422.3 1429.4 895.4 923.4 944.1 946.7 960.2 5234.6 5235.8 5244.4 5257.3 5275.4 5520.9 5523.7 5530.9 5535.0 5544.6 4993.7 5137.6 5240.6 5253.2 5253.3 2888.0 2898.9 2901.7 2902.3 2923.2 5688.1 5721.5 5723.9 5729.6 5758.4 5414.6 5618.6 5621.3 5638.9 5651.7 5684.4 5700.5 5714.0 5736.5 5750.1 5324.9 5532.6 5533.4 5547.7 5583.0 5418.7 5483.7 5488.4 5511.6 5511.6 5615.5 5686.7 5727.0 5748.5 5781.5 3819.2 4030.4 4052.6 4053.1 4060.8 5507.8 5518.5 5534.3 5536.9 5540.2 5444.8 5486.8 5494.7 5497.3 5504.4 5180.9 5360.7 5434.8 5441.4 5499.4 5383.1 5405.2 5434.3 5440.3 5455.5 5264.7 5297.8 5450.4 5474.1 5487.2 5336.8 5376.5 5376.8 5380.5 5390.7 02:27:33 INFO - PROCESS | 14011 | 02:27:33 INFO - PROCESS | 14011 | [#5] yui.html Cycles:180 Average:22788.32 Median:3949.61 stddev:34415.13 (871.4%) stddev-sans-first:34471.82 02:27:33 INFO - PROCESS | 14011 | Values: 731.6 736.6 742.9 750.0 784.8 15699.8 16829.3 17306.8 17373.9 17626.2 16213.6 16345.9 16353.3 16354.3 16362.4 671.8 801.3 819.7 821.3 823.6 797.9 815.1 816.6 829.5 832.1 854.2 856.4 857.0 857.0 858.4 631.3 842.6 848.0 850.1 852.0 601.8 615.8 616.4 622.0 622.1 13883.1 13915.7 13930.4 13941.6 13976.4 13183.0 13248.4 13931.4 14181.4 14464.6 12265.4 12365.8 12553.3 12589.3 12724.4 3918.3 3980.9 4004.3 4058.1 4120.2 82256.2 83406.2 83649.6 83935.6 84561.2 10599.4 11205.9 11340.8 11615.1 11665.9 18836.2 19921.6 20101.5 20128.0 20130.2 8209.8 8283.3 8355.5 8542.4 8846.8 4208.9 4348.7 4397.3 4429.8 4539.9 3625.2 3745.7 3752.4 3753.1 3757.3 643.1 643.8 656.2 660.4 665.9 630.4 673.0 696.7 742.0 794.9 10333.9 10619.2 10624.6 10915.8 10987.5 646.6 708.1 734.3 766.9 796.4 4901.7 5131.2 5148.6 5178.0 5213.5 131459.0 133072.3 135106.3 136278.0 136345.0 112532.4 113657.4 114978.0 117234.0 118313.4 82421.0 93118.0 94571.0 94858.5 98264.0 9498.8 9607.0 9742.9 9765.6 9802.5 42008.8 56447.4 56857.4 57393.7 59505.7 82032.2 85337.0 90336.5 91827.0 93234.5 12156.8 12548.6 12578.4 12829.9 13373.9 13734.2 13768.6 14328.3 14465.6 14700.0 12267.8 13443.8 13694.2 13710.8 14369.9 13937.5 14512.7 14597.6 15321.2 15343.4 14405.4 14551.3 14733.2 14826.5 15012.3 11745.4 12649.9 12732.2 12737.9 12753.4 10535.5 11460.2 11602.0 11956.5 12384.0 02:27:33 INFO - PROCESS | 14011 | -------- Summary: end -------- 02:27:33 INFO - PROCESS | 14011 | 02:27:34 INFO - TEST-INFO | 14011: exit 0 02:27:34 INFO - TEST-OK | dromaeo_css | took 1115468ms 02:27:34 INFO - TEST-START | kraken 02:27:34 INFO - operating with platform_type : linux_ 02:27:34 INFO - Initialising browser for kraken test... 02:27:34 INFO - TEST-INFO | started process 14321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpij7q8R/profile http://localhost:41949/getInfo.html) 02:27:38 INFO - PROCESS | 14321 | __metrics Screen width/height:1600/1200 02:27:38 INFO - PROCESS | 14321 | colorDepth:24 02:27:38 INFO - PROCESS | 14321 | Browser inner width/height: 1024/697 02:27:38 INFO - PROCESS | 14321 | __metrics 02:27:39 INFO - PROCESS | 14321 | 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" 02:27:39 INFO - PROCESS | 14321 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:39 INFO - PROCESS | 14321 | console.error: PushService: 02:27:39 INFO - PROCESS | 14321 | stateChangeProcessEnqueue: Error transitioning state 02:27:39 INFO - PROCESS | 14321 | UnknownError 02:27:40 INFO - TEST-INFO | 14321: exit 0 02:27:40 INFO - Browser initialized. 02:27:40 INFO - Running cycle 1/1 for kraken test... 02:27:40 INFO - TEST-INFO | started process 14405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpij7q8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:52 INFO - PROCESS | 14405 | RSS: Main: 154447872 02:27:52 INFO - PROCESS | 14405 | 02:27:54 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41949/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:55 INFO - PROCESS | 14405 | RSS: Main: 202960896 02:27:55 INFO - PROCESS | 14405 | 02:27:58 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41949/tests/kraken/driver.html?testName=audio-dft) 02:27:58 INFO - PROCESS | 14405 | RSS: Main: 193605632 02:27:58 INFO - PROCESS | 14405 | 02:28:01 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41949/tests/kraken/driver.html?testName=audio-fft) 02:28:02 INFO - PROCESS | 14405 | RSS: Main: 274735104 02:28:02 INFO - PROCESS | 14405 | 02:28:04 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41949/tests/kraken/driver.html?testName=audio-oscillator) 02:28:05 INFO - PROCESS | 14405 | RSS: Main: 184188928 02:28:05 INFO - PROCESS | 14405 | 02:28:07 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:07 INFO - PROCESS | 14405 | RSS: Main: 189550592 02:28:07 INFO - PROCESS | 14405 | 02:28:10 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41949/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:11 INFO - PROCESS | 14405 | RSS: Main: 224821248 02:28:11 INFO - PROCESS | 14405 | 02:28:14 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41949/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:15 INFO - PROCESS | 14405 | RSS: Main: 225296384 02:28:15 INFO - PROCESS | 14405 | 02:28:18 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41949/tests/kraken/driver.html?testName=json-parse-financial) 02:28:18 INFO - PROCESS | 14405 | RSS: Main: 225435648 02:28:18 INFO - PROCESS | 14405 | 02:28:20 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:20 INFO - PROCESS | 14405 | RSS: Main: 187342848 02:28:20 INFO - PROCESS | 14405 | 02:28:22 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:23 INFO - PROCESS | 14405 | RSS: Main: 193634304 02:28:23 INFO - PROCESS | 14405 | 02:28:25 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:25 INFO - PROCESS | 14405 | RSS: Main: 192217088 02:28:25 INFO - PROCESS | 14405 | 02:28:28 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:29 INFO - PROCESS | 14405 | RSS: Main: 185618432 02:28:29 INFO - PROCESS | 14405 | 02:28:31 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:32 INFO - PROCESS | 14405 | RSS: Main: 190496768 02:28:32 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:41949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41949/tests/kraken/driver.html?testName=ai-astar) 02:28:34 INFO - PROCESS | 14405 | RSS: Main: 240869376 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | __start_tp_report 02:28:34 INFO - PROCESS | 14405 | _x_x_mozilla_page_load 02:28:34 INFO - PROCESS | 14405 | _x_x_mozilla_page_load_details 02:28:34 INFO - PROCESS | 14405 | |i|pagename|runs| 02:28:34 INFO - PROCESS | 14405 | |0;ai-astar;104;111;113;112;110;113;112;113;111;112 02:28:34 INFO - PROCESS | 14405 | |1;audio-beat-detection;150;123;122;188;119;126;140;118;160;121 02:28:34 INFO - PROCESS | 14405 | |2;audio-dft;160;160;161;160;160;161;161;159;160;161 02:28:34 INFO - PROCESS | 14405 | |3;audio-fft;74;74;76;102;75;76;75;75;101;74 02:28:34 INFO - PROCESS | 14405 | |4;audio-oscillator;84;84;119;86;86;85;127;85;85;128 02:28:34 INFO - PROCESS | 14405 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;117;117 02:28:34 INFO - PROCESS | 14405 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;146 02:28:34 INFO - PROCESS | 14405 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 02:28:34 INFO - PROCESS | 14405 | |8;json-parse-financial;52;49;52;51;51;54;53;51;52;51 02:28:34 INFO - PROCESS | 14405 | |9;json-stringify-tinderbox;61;61;60;62;62;61;60;62;61;61 02:28:34 INFO - PROCESS | 14405 | |10;stanford-crypto-aes;78;78;78;78;80;78;79;80;78;87 02:28:34 INFO - PROCESS | 14405 | |11;stanford-crypto-ccm;140;128;122;126;127;125;135;122;139;132 02:28:34 INFO - PROCESS | 14405 | |12;stanford-crypto-pbkdf2;160;164;163;161;161;162;162;160;161;159 02:28:34 INFO - PROCESS | 14405 | |13;stanford-crypto-sha256-iterative;64;64;67;64;71;64;65;64;62;61 02:28:34 INFO - PROCESS | 14405 | __end_tp_report 02:28:34 INFO - PROCESS | 14405 | __start_cc_report 02:28:34 INFO - PROCESS | 14405 | _x_x_mozilla_cycle_collect,1612 02:28:34 INFO - PROCESS | 14405 | __end_cc_report 02:28:34 INFO - PROCESS | 14405 | __startTimestamp1471426114289__endTimestamp 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | ------- Summary: start ------- 02:28:34 INFO - PROCESS | 14405 | Number of tests: 14 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.69 (2.4%) stddev-sans-first:1.05 02:28:34 INFO - PROCESS | 14405 | Values: 104.0 111.0 113.0 112.0 110.0 113.0 112.0 113.0 111.0 112.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:133.00 stddev:23.07 (17.3%) stddev-sans-first:23.96 02:28:34 INFO - PROCESS | 14405 | Values: 150.0 123.0 122.0 188.0 119.0 126.0 140.0 118.0 160.0 121.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 02:28:34 INFO - PROCESS | 14405 | Values: 160.0 160.0 161.0 160.0 160.0 161.0 161.0 159.0 160.0 161.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.25 (15.0%) stddev-sans-first:11.71 02:28:34 INFO - PROCESS | 14405 | Values: 74.0 74.0 76.0 102.0 75.0 76.0 75.0 75.0 101.0 74.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:19.31 (22.7%) stddev-sans-first:19.91 02:28:34 INFO - PROCESS | 14405 | Values: 84.0 84.0 119.0 86.0 86.0 85.0 127.0 85.0 85.0 128.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:28:34 INFO - PROCESS | 14405 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:28:34 INFO - PROCESS | 14405 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:28:34 INFO - PROCESS | 14405 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.35 (2.6%) stddev-sans-first:1.42 02:28:34 INFO - PROCESS | 14405 | Values: 52.0 49.0 52.0 51.0 51.0 54.0 53.0 51.0 52.0 51.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 02:28:34 INFO - PROCESS | 14405 | Values: 61.0 61.0 60.0 62.0 62.0 61.0 60.0 62.0 61.0 61.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.50 stddev:2.80 (3.6%) stddev-sans-first:2.92 02:28:34 INFO - PROCESS | 14405 | Values: 78.0 78.0 78.0 78.0 80.0 78.0 79.0 80.0 78.0 87.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:130.00 stddev:6.59 (5.1%) stddev-sans-first:5.81 02:28:34 INFO - PROCESS | 14405 | Values: 140.0 128.0 122.0 126.0 127.0 125.0 135.0 122.0 139.0 132.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 02:28:34 INFO - PROCESS | 14405 | Values: 160.0 164.0 163.0 161.0 161.0 162.0 162.0 160.0 161.0 159.0 02:28:34 INFO - PROCESS | 14405 | 02:28:34 INFO - PROCESS | 14405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:2.76 (4.3%) stddev-sans-first:2.92 02:28:34 INFO - PROCESS | 14405 | Values: 64.0 64.0 67.0 64.0 71.0 64.0 65.0 64.0 62.0 61.0 02:28:34 INFO - PROCESS | 14405 | -------- Summary: end -------- 02:28:34 INFO - PROCESS | 14405 | 02:28:35 INFO - TEST-INFO | 14405: exit 0 02:28:35 INFO - TEST-OK | kraken | took 60563ms 02:28:35 INFO - SUITE-END | took 1176s 02:28:35 INFO - Completed test suite (00:19:36) 02:28:35 INFO - javascript benchmark 02:28:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.403416333814, 3079.1840162356993, 3086.1667349815543, 3104.28601421673, 3109.1760683418884, 5104.795808167678, 5136.818531737693, 5272.710000949946, 5376.408595054546, 5428.131498960167, 5285.4450282720245, 5374.355077390718, 5392.514673679368, 5414.187871819229, 5472.808451704191, 4763.571278584926, 4827.25177597473, 4857.587105096053, 4865.34317867087, 5021.322121513604, 4932.556069953704, 4951.0592987332475, 4978.676386034915, 4997.0, 5017.473165317644, 4716.716996980175, 4788.018456216502, 4791.377120974286, 4857.125717370872, 4945.876353091166, 4811.254255590354, 4815.711057336571, 4816.397950256218, 4861.440934292566, 4918.262260660894, 4813.951860481386, 4816.566509014206, 4817.181079216542, 4828.106800241966, 4912.680675756064, 5218.060749065166, 5258.553022993012, 5320.946790532123, 5337.172738225581, 5397.946020539784, 5739.253896993406, 5742.454466825645, 5764.654120752768, 5780.653160810365, 5794.97102514489, 5794.362620111784, 5794.5943783935145, 5795.855103622401, 5820.156077368758, 5834.766609335621, 5235.188545775411, 5292.047431462335, 5361.0, 5374.35507739066, 5476.616636835463, 5920.230370051866, 5935.792247271324, 5948.0, 5950.851228719317, 5954.612950158225, 5687.971560142256, 5691.0, 5736.311642602915, 5739.253896993448, 5739.741711622987, 5521.696306703089, 5659.915101273484, 5726.255586773693, 5740.741666625012, 5846.853828654318, 5766.077427611646, 5766.3368712598585, 5766.452187042224, 5772.480476757112, 5780.104083867007, 5705.942940570624, 5711.428857114255, 5771.971140144273, 5777.826665200051, 5781.075027995501, 4308.6983911126545, 4326.3510473428605, 4332.805023773938, 4394.692371534026, 4397.1205758848355, 3943.921121577552, 3968.6031396860662, 3968.642822145963, 3973.1854969731135, 3973.3642617181113, 5383.730813459311, 5399.190121481731, 5409.6754194747655, 5412.052890744104, 5551.694656793915, 5839.824805255849, 5845.240118784531, 5847.386024467455, 5875.059990401601, 5889.646621202742, 5445.945540544623, 5493.835184944458, 5507.531859791882, 5510.035743744908, 5513.117901135799, 4808.903821923542, 4844.975775121102, 4893.143699852511, 4975.0, 5023.09584274834, 5951.315598706205, 5988.820335389945, 6020.729067191987, 6027.126066720301, 6035.426634469718, 5710.971445142748, 5746.166805813217, 5759.337676167294, 5778.624389414675, 5782.306123265067, 5760.423957604206, 5912.704364781658, 5990.400959903975, 5995.0, 5997.0, 5665.150227465913, 5777.566682498746, 5804.390538993345, 5806.0, 5822.446867547576, 5842.737076831638, 5852.648841069549, 5867.090600956688, 5868.530517558671, 5869.207656966255, 5405.567554595545, 5656.858578535405, 5683.5453163747625, 5708.229389032594, 5721.8569535761935, 5522.2544956430365, 5606.887862242814, 5641.464060914371, 5731.369549349652, 5775.0, 5615.129654903497, 5649.4633009864, 5669.631473954345, 5670.9432905672065, 5673.77304907799, 5472.808451704172, 5749.281339832521, 5762.683052432157, 5791.594588378773, 5811.53507719373, 5426.891462170814, 5465.781368745205, 5486.094794359045, 5578.0, 5583.609147359808], "value": 5311.033570557069, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.764094362255, 603.5473394953784, 622.4833388287722, 631.1637080867849, 639.8048595178469, 31834.044978650618, 32290.515642265356, 35649.643503564956, 35833.64166358336, 42272.15455690892, 45647.31529027067, 45760.313595296095, 45778.08443831121, 45786.542134578725, 45872.77063614677, 8755.693550725742, 8912.465252084896, 8914.375993680413, 8985.595648195815, 9004.279657627374, 8904.0, 8996.77508062297, 9001.099890011012, 9001.50491722955, 9002.234810041155, 9004.459732416077, 9048.276137908984, 9051.275897928183, 9051.456912585232, 9052.592633331516, 8956.0, 8957.14907083826, 8963.238124759404, 9002.459852408876, 9004.909950900472, 8899.110088991114, 8906.153915378029, 8957.865632015524, 8968.327375446803, 8974.0, 43676.0, 43755.34366984498, 44000.11999759987, 44069.55930440719, 44124.55875441236, 3380.746444016684, 3800.8289626966853, 3804.068003339172, 4029.7985100744845, 4170.561156401037, 32925.83537082299, 33034.6696533034, 33726.1568460788, 33801.154971125674, 34098.48852267218, 4413.6910416270875, 4477.3731677565165, 4482.125985432842, 4521.819127234907, 4603.033362993775, 344529.0, 345740.0, 347091.0, 348099.0, 348302.99999999744, 59570.0, 59780.0, 59896.70568118795, 59978.70010650006, 60108.0, 33937.0, 34390.48414273788, 34544.48183277253, 62692.0, 62692.37307626956, 17565.121743912754, 17739.29042838272, 17741.46775596734, 17746.29014839392, 17799.377021804175, 13382.598522044354, 13429.0, 13471.865281347256, 13482.528111516245, 13483.460661573623, 19441.533686616192, 19484.123214455383, 19497.707534386995, 19707.507312317306, 19807.801921980597, 6908.930910690829, 6966.1988871280455, 7135.785926422215, 7247.601381924045, 7307.8538429232185, 963.6964356227766, 989.1345073061071, 1064.1061508332882, 1093.8413929980109, 1139.2310190621463, 32551.348973020406, 33029.0, 33038.83480582582, 33059.0, 33239.537807579705, 1069.2461814420815, 1089.4334945828284, 1108.6396921000546, 1141.5433826469311, 1163.743976325207, 15718.21408929549, 16556.42052528156, 16653.666926661397, 16805.495835124966, 16980.40568580094, 537760.0, 543443.0, 545717.0, 548824.0, 549465.0, 57891.42108578944, 58367.416325837046, 58454.415455845745, 58455.0, 58566.0, 1287.0668765145383, 1383.7163381506766, 1406.5709958462767, 1417.2346932656455, 1442.048248156212, 29445.558316625695, 33638.663613363555, 33674.0, 34179.0, 34370.0, 50461.24308135454, 51078.744606276734, 51114.74442627763, 51118.0, 51120.74439627927, 427788.0, 429562.0, 431088.0, 432312.0, 433853.0, 28936.421271574873, 29311.70688293175, 37034.25931481301, 45011.774941125084, 45518.77240613908, 45962.0, 50788.74605626948, 50841.237381438565, 50940.0, 51033.0, 41848.13746444025, 44020.77989610031, 44026.0, 44570.3314450277, 45327.32009019933, 42696.35955460733, 43018.35472467853, 43041.569584303754, 44485.555144449434, 45528.317075243234, 35289.63965483166, 36941.44587831131, 37206.6279337214, 42880.35679464873, 44663.55336446594, 30455.543166852956, 38681.6131838678, 39287.0, 40083.198336033696, 40331.59668403278, 27991.562228564337, 28927.0, 30126.246843829078, 30194.69805301919, 31173.688263117077], "value": 20443.126722311616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.12611749680724, 394.8381163722874, 401.19560281635324, 404.07668477528847, 423.62720805690986, 13700.931495342535, 18824.623507529843, 20461.795382046173, 20749.273775417863, 20759.896200518997, 18188.09059547024, 18522.259109635597, 19944.800551994475, 20609.587808243825, 20965.790342096574, 5792.594518383715, 5921.674307913063, 5932.406759324076, 5933.3473317934995, 5936.050231962887, 5809.2738407699035, 5888.440598143191, 5891.64650120992, 5898.203742494751, 5909.025010873201, 4167.45823043004, 5299.708516031636, 6481.935180648204, 6506.219253689564, 6628.171478565179, 5628.634138780966, 5885.882282354329, 6610.966945165267, 6654.767083152091, 6656.866862662744, 5794.362620111827, 5800.100984347433, 5805.767769289223, 5808.680522571257, 5812.82561523155, 14894.0, 23551.646725299135, 23554.76445235543, 23778.64332035021, 24431.87784061086, 2534.746525347469, 2643.5638119710225, 2656.495265899473, 3031.090672798152, 3053.328267781085, 10297.22770792186, 10436.37381757097, 10838.349699018085, 10991.505382257817, 11199.160062995308, 2001.6497113005166, 2005.2179649936536, 2008.8794672319707, 2012.8892910889895, 2020.8181263686338, 61449.53400753529, 62254.0, 74749.6262518684, 79040.60479697623, 79416.20583794145, 11192.888071119347, 11402.429878506042, 11462.140339474572, 11504.712382190512, 11741.706457338634, 16199.43301984425, 16215.83784162167, 16237.269322880498, 16249.593760155854, 16250.0, 8437.282830959315, 8673.089325620846, 8737.30101591871, 8884.644614215358, 8908.643654253887, 7491.887621685679, 7887.487313324616, 7900.644470998819, 7908.922720948723, 8091.0695270043525, 4842.709437433765, 4879.829205977845, 4892.48628893961, 5024.0, 5037.269595908573, 1931.4785008047747, 1980.1188471130208, 2005.488600406916, 2034.2269937423684, 2039.8878061706453, 878.5914549734404, 953.4898829126384, 959.3859929645033, 1021.3412349034979, 1028.7788125552893, 17479.912600436917, 20149.294774682814, 20801.0, 20970.0, 21199.470013249484, 974.4932635029745, 978.2418625565244, 1013.1489548778914, 1014.898510148994, 1026.4559783314855, 10335.984483025737, 11251.381174035343, 11403.714907127222, 11521.07831373488, 11530.866789643942, 529734.0, 535687.0, 536301.0, 539444.0, 546274.0, 93509.0, 93574.53212733893, 94464.52767736117, 96224.51887740516, 96455.0, 937.5921474158763, 976.1653786012856, 992.8163289791412, 999.0359303272231, 1015.5328548867603, 17679.292828286725, 17898.0, 18565.25738970426, 18576.721349180043, 18868.622627547098, 44696.762107843744, 44780.776096120615, 44996.55003449923, 45115.097698045196, 45974.310385343575, 61415.692921536895, 61577.69211153915, 61952.831650892, 63172.36827631665, 64023.359766401736, 6016.729247183975, 7197.928020719935, 8149.348052155695, 8300.667973281243, 8634.150730258874, 7569.924300756922, 10877.401742904216, 11489.712757181138, 13583.592492225249, 13829.239391833546, 11885.643430697093, 11916.702082448008, 12092.818607720716, 12173.513059477522, 12249.87750122523, 11780.823287650863, 11794.410279486163, 11828.17202795796, 12205.328706921204, 12573.497060117494, 11585.362805045466, 11752.471138798946, 11780.234284771463, 12069.939650301692, 12100.515979361078, 8126.878096828671, 8266.586670666322, 8285.212904774036, 8411.62147703367, 8515.531645759544, 11445.370504622326, 11712.238704484182, 11823.645290641294, 11827.645170644895, 12320.568780092653], "value": 9408.052405409526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.86791320868, 1443.9566812995606, 1494.7160039592477, 1573.5436723350228, 1721.819208983056, 8272.66909323627, 8687.826243475134, 8719.869201961976, 8962.955185224066, 8969.147930946567, 8740.606672699729, 8853.424527405714, 8856.158664926837, 8864.867026994583, 8872.512011839346, 2078.2310545098335, 2346.507233480967, 2369.455025344172, 2376.192094687806, 2378.583747844129, 2438.8414753041084, 2448.338948483908, 2453.1414005098163, 2459.86470744109, 2465.359006658273, 2335.5562443135836, 2343.379004563792, 2349.3656712687566, 2350.788429041386, 2371.833971621987, 2207.0950910126853, 2211.8341124415733, 2215.091812356926, 2281.885905704708, 2353.8940747666225, 2413.3001429585397, 2419.9395015124765, 2421.9515609687883, 2428.138011006085, 2429.9149529766373, 8681.175288347597, 8716.825663486758, 8732.8690069649, 8736.213740763298, 8759.868601970975, 5227.242049902781, 5236.345456817898, 5263.6578622389425, 5341.946580534183, 5389.245505629176, 3440.7591468597207, 3528.2414280929725, 3589.5333606631234, 3600.6219346968714, 3601.8019008954498, 1146.2549342927082, 1174.2250114924195, 1235.234154824015, 1246.1588427811191, 1272.389253158489, 12524.812127817999, 12610.180338278074, 12665.810012849815, 12671.0, 12681.556145534954, 4333.674974376871, 4435.26818075014, 4637.907241855144, 4639.30410438437, 4707.7881495332795, 9774.364666296668, 9774.657886973922, 9780.755481112887, 9815.705528834147, 9824.852627210597, 5289.471052894757, 5291.894162116813, 5298.443663415363, 5298.841034768963, 5300.628955973045, 4307.138572285556, 4776.068666610047, 4815.2054910940005, 4945.901081978341, 4954.256861470808, 3652.7625704329134, 3714.7028237740915, 3806.9619303807162, 3822.7515211511163, 3832.0994566276904, 1124.2355198465123, 1143.1540659911773, 1145.3929417408788, 1146.1804809561038, 1150.3960420779158, 872.9825403491894, 873.4104479476329, 893.097971049245, 897.6588896219395, 941.9764505887271, 5618.91571626426, 5662.8301150965535, 5713.8285851424525, 5737.569682273846, 5848.824535263949, 928.8374534456443, 937.3204426790522, 944.7071407863584, 947.4788866123605, 958.9808203836023, 3744.719146064056, 3884.7280690351404, 3889.980550097288, 3918.529776426847, 3926.7251292409255, 11103.111751059896, 11370.31778093317, 11381.430928453545, 11411.771764564663, 11443.0, 11301.039411649937, 11317.0, 11319.320840749417, 11319.717007074725, 11337.0, 7856.685732570748, 8096.392770542115, 8137.877931831027, 8170.3872209584515, 8306.584670766437, 5682.602217844711, 5849.356570777126, 5881.794137205348, 5974.2233509643465, 6000.609960352563, 10394.844077338998, 10482.63310784119, 10504.212184086071, 10576.206784491347, 10665.733356665834, 10215.387076775418, 10383.740406489596, 10501.632442864464, 10625.840612390975, 10637.680869573926, 7132.465065120241, 7330.560166390033, 7344.48588598793, 7969.362451004022, 8171.101178870201, 8255.917440825515, 8366.33069354438, 8622.52576108295, 8631.13688631157, 8868.379213455255, 7504.774856754306, 7675.385969122569, 7763.4953728007495, 7769.300762931363, 7797.0, 7660.846783064419, 7865.646045927832, 7881.290683838482, 7883.881741773993, 8100.554469504234, 7093.361597456254, 7213.0, 7213.963930180315, 7217.6752046157, 7230.6384680764695, 4948.851534453972, 4949.737816856678, 4983.401991760867, 5015.452450743724, 5227.686338819683, 4957.603391728725, 5103.157978933435, 5105.157648987875, 5106.029854327666, 5138.665986710852], "value": 4634.0530507509575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5859816631045, 334.9430596798544, 338.37569683933134, 345.2921510902649, 346.42493460855, 5243.501867322603, 5250.188684903707, 5264.263003179553, 5269.8155564555245, 5327.706976116312, 5202.583793296537, 5223.138182199932, 5268.236105764662, 5270.525652691266, 5273.314469119019, 3947.1316310411735, 3962.48487696599, 4057.1337184894837, 4059.3302105152616, 4092.6112019358116, 4082.755034697913, 4088.121053973395, 4099.7745124018165, 4105.2815757242515, 4110.321796903522, 4025.9798701006453, 4036.636702696757, 4044.0992733415246, 4067.779666100158, 4071.6742660587083, 3854.7879866607327, 3920.3335432976464, 4059.634632883025, 4091.8772436826944, 4094.9385759213637, 3671.687906527948, 3677.9816100919325, 3679.632036796326, 3687.631236876318, 3692.132348898007, 5086.237064440364, 5118.488151184889, 5132.28148059272, 5135.229715542661, 5136.74316284188, 4413.933790993137, 4636.53634636537, 4658.114958157939, 4660.440747110369, 4672.15901137795, 5415.729213539307, 5422.105352616813, 5446.786396026363, 5447.945520544823, 5448.891022179534, 3946.605339466059, 3951.7431366961055, 3954.980225098856, 3956.8219430125714, 3976.1848820991627, 5474.370447398521, 5585.5531557475715, 5587.580931430159, 5596.496315331639, 5677.0, 4022.7988600569856, 4024.3561030235023, 4026.7986600670433, 4031.737937034083, 4049.5545489996075, 4058.350663893763, 4062.5734297898885, 4063.674906007512, 4068.6745060395097, 4080.7959602019782, 4447.710898791633, 4608.792604332813, 4660.790264438108, 4663.743494107789, 4666.696664716783, 5474.863128421821, 5484.314460692413, 5486.0, 5497.532709719639, 5528.861778455571, 1390.2978995607357, 1398.5664444022386, 1421.3796272249645, 1422.3315041930275, 1429.3639330497829, 895.3642913531336, 923.3536524432924, 944.1125342178331, 946.7159852044359, 960.2222200018008, 5234.581233501311, 5235.790568377299, 5244.370675518962, 5257.2902658140665, 5275.419703832576, 5520.944790552043, 5523.674318163692, 5530.86172845674, 5535.0, 5544.61187716856, 4993.675411098267, 5137.5889928806355, 5240.6069544784295, 5253.1632918224495, 5253.264542963988, 2888.00363874463, 2898.8984186009184, 2901.6953219911607, 2902.332463533357, 2923.2399576110365, 5688.075228092685, 5721.456461636138, 5723.942760572424, 5729.570282228766, 5758.395368486333, 5414.566834653218, 5618.550515958714, 5621.297337832771, 5638.85902852432, 5651.689157096317, 5684.37471878093, 5700.515456186187, 5714.0, 5736.512396446349, 5750.137479378127, 5324.866878328073, 5532.585056120726, 5533.363663178786, 5547.667139971614, 5582.972085139549, 5418.701971391612, 5483.670979741229, 5488.4237155098135, 5511.622094476381, 5511.641743286674, 5615.494605485526, 5686.692060825951, 5727.0, 5748.540116790563, 5781.479666830005, 3819.2361527694015, 4030.4357389966017, 4052.594740525924, 4053.108316170438, 4060.7563546187325, 5507.752151153128, 5518.503334699896, 5534.335879694462, 5536.944630553643, 5540.196671482693, 5444.782208711607, 5486.835394938158, 5494.697791621499, 5497.340319161726, 5504.366997795145, 5180.922286165786, 5360.678359298455, 5434.83695489136, 5441.374241962225, 5499.4225606310765, 5383.08487557124, 5405.162244836774, 5434.266374039454, 5440.347158341025, 5455.509004189642, 5264.710440925633, 5297.807993201653, 5450.400455949922, 5474.09677403224, 5487.2317875496665, 5336.813211537577, 5376.462353764592, 5376.7580458878665, 5380.488853558905, 5390.703511306759], "value": 4165.30918500827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.5500966905355, 736.6390468670346, 742.8885667149926, 749.9962500187498, 784.7841843493038, 15699.843001569996, 16829.326826926925, 17306.82693173068, 17373.913130434346, 17626.206820693067, 16213.594660133473, 16345.91827040863, 16353.345866165339, 16354.345826166938, 16362.427315043977, 671.7715976567966, 801.2908575910303, 819.6557445872718, 821.3306155483263, 823.5593957232882, 797.9401544884128, 815.0871024452591, 816.5957850863831, 829.5437509369852, 832.1013305629905, 854.2269246332079, 856.3577317012241, 857.01443340159, 857.0358346859783, 858.4205661178711, 631.28664608992, 842.6292431330195, 848.0205362805968, 850.132864478235, 851.9616617252238, 601.7653115285042, 615.7629312714593, 616.3897741236188, 622.0451606783565, 622.0855342646303, 13883.097598656055, 13915.721685566232, 13930.37313320903, 13941.58175254744, 13976.371063302075, 13183.0, 13248.40382182804, 13931.373088211054, 14181.361838717283, 14464.566063018126, 12265.448054837465, 12365.75268494625, 12553.309567973758, 12589.30758808265, 12724.363781810966, 3918.314294998364, 3980.900477488057, 4004.279229738646, 4058.0666446717123, 4120.175964807021, 82256.17743822605, 83406.16593834106, 83649.58175209085, 83935.58032209861, 84561.15438845594, 10599.364038157735, 11205.94397028026, 11340.773184536429, 11615.128865335133, 11665.88334116648, 18836.152373143243, 19921.60156796856, 20101.49746256355, 20128.0, 20130.19479220815, 8209.8358032839, 8283.337333013344, 8355.540445275568, 8542.359323050796, 8846.823063538694, 4208.85269015583, 4348.652107831366, 4397.2964325707735, 4429.7785110744335, 4539.865033741565, 3625.220577575834, 3745.7377983541437, 3752.437134429803, 3753.0617345663586, 3757.3236817373136, 643.112504743451, 643.8197304754676, 656.153561905137, 660.3858411677186, 665.9400653941168, 630.4357599948021, 672.9966350168315, 696.7039008421502, 741.9666115024837, 794.89666343375, 10333.948330258301, 10619.185915732338, 10624.575016999388, 10915.836262456069, 10987.505562249718, 646.6178815095042, 708.1042481261209, 734.2657342657343, 766.9079710434784, 796.38678217772, 4901.730404827768, 5131.153359695683, 5148.639595228373, 5177.974110129425, 5213.530782229617, 131459.0, 133072.3346383262, 135106.32446837702, 136278.0, 136345.0, 112532.4373378128, 113657.4317128409, 114978.0, 117234.0, 118313.40843295901, 82421.0, 93118.0, 94571.0, 94858.52570737102, 98264.0, 9498.810023799348, 9607.0, 9742.853857192289, 9765.560549775419, 9802.50987450639, 42008.78995605002, 56447.43552564586, 56857.431425685216, 57393.71303143458, 59505.70247148736, 82032.17967820246, 85337.0, 90336.54831726062, 91827.0, 93234.53382733042, 12156.817647735468, 12548.560800371943, 12578.371081446074, 12829.871701282867, 13373.866261337262, 13734.244616545786, 13768.586942391745, 14328.283585820458, 14465.566033019026, 14700.0, 12267.754644906874, 13443.798343024668, 13694.246816425193, 13710.794338085136, 14369.856301436852, 13937.512187073404, 14512.709745805236, 14597.562073137822, 15321.19478300571, 15343.386264549294, 14405.351759171072, 14551.27243637835, 14733.189674567573, 14826.481073162387, 15012.324445399765, 11745.354005529778, 12649.87350126487, 12732.23606583608, 12737.93631031839, 12753.362331883554, 10535.4732263385, 11460.197786155222, 11602.0, 11956.521739130338, 12384.0], "value": 7808.281201342405, "unit": "score"}], "name": "dromaeo_css", "value": 7321.039851039634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 112.0, 110.0, 113.0, 112.0, 113.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 188.0, 119.0, 126.0, 140.0, 118.0, 160.0, 121.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 159.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 102.0, 75.0, 76.0, 75.0, 75.0, 101.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 86.0, 86.0, 85.0, 127.0, 85.0, 85.0, 128.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 52.0, 51.0, 51.0, 54.0, 53.0, 51.0, 52.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 62.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 80.0, 78.0, 79.0, 80.0, 78.0, 87.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 122.0, 126.0, 127.0, 125.0, 135.0, 122.0, 139.0, 132.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 163.0, 161.0, 161.0, 162.0, 162.0, 160.0, 161.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 64.0, 71.0, 64.0, 65.0, 64.0, 62.0, 61.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1489.5, "alertThreshold": 2.0}]} 02:28:35 INFO - Return code: 0 02:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:28:35 INFO - # TBPL SUCCESS # 02:28:35 INFO - Running post-action listener: _resource_record_post_action 02:28:35 INFO - [mozharness: 2016-08-17 09:28:35.628023Z] Finished run-tests step (success) 02:28:35 INFO - Running post-run listener: _resource_record_post_run 02:28:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 408936448; Read time: 0; Write time: 256100 02:28:35 INFO - TinderboxPrint: CPU usage
12.9% 02:28:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:28:35 INFO - TinderboxPrint: I/O write bytes / time
408,936,448 / 256,100 02:28:35 INFO - TinderboxPrint: CPU idle
8,288.6 (87.0%) 02:28:35 INFO - TinderboxPrint: CPU user
1,189.8 (12.5%) 02:28:35 INFO - TinderboxPrint: Swap in / out
0 / 0 02:28:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117211136; Read time: 0; Write time: 73640 02:28:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 291086336; Read time: 0; Write time: 182380 02:28:36 INFO - Running post-run listener: _upload_blobber_files 02:28:36 INFO - Blob upload gear active. 02:28:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:36 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 02:28:36 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:36 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:36 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:41 INFO - (blobuploader) - INFO - Done attempting. 02:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:42 INFO - (blobuploader) - INFO - Done attempting. 02:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:42 INFO - (blobuploader) - INFO - Done attempting. 02:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:42 INFO - Return code: 0 02:28:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b254743a5234f6c3da8639ab8dd8058f18b0ca459e4355d0db5884ec907191928cd630e573db3174f4780a280b2b8d251741ac4f8e37ded1ff6fcd831063aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c16b30bca1c1e3ed2d0467cb94899f11350ac8b9d2359ce7b8a2ac34340ae1ff59a8b3c03ce491be0e177d53b522ea835312d897537138564318788fd35ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f051e77506bcb0c7544bc588ea5eee8eb4c8f5d44c0726bdda2f52809eb928c44ac57ec41238cac1d60d92cefe87a5970e284998212a53078b05b02fe633fa3a"} 02:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:42 INFO - Contents: 02:28:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b254743a5234f6c3da8639ab8dd8058f18b0ca459e4355d0db5884ec907191928cd630e573db3174f4780a280b2b8d251741ac4f8e37ded1ff6fcd831063aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c16b30bca1c1e3ed2d0467cb94899f11350ac8b9d2359ce7b8a2ac34340ae1ff59a8b3c03ce491be0e177d53b522ea835312d897537138564318788fd35ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f051e77506bcb0c7544bc588ea5eee8eb4c8f5d44c0726bdda2f52809eb928c44ac57ec41238cac1d60d92cefe87a5970e284998212a53078b05b02fe633fa3a"} 02:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:42 INFO - Copying logs to upload dir... 02:28:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.322740 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-17 02:28:42.649619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 02:28:42.652566) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b254743a5234f6c3da8639ab8dd8058f18b0ca459e4355d0db5884ec907191928cd630e573db3174f4780a280b2b8d251741ac4f8e37ded1ff6fcd831063aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c16b30bca1c1e3ed2d0467cb94899f11350ac8b9d2359ce7b8a2ac34340ae1ff59a8b3c03ce491be0e177d53b522ea835312d897537138564318788fd35ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f051e77506bcb0c7544bc588ea5eee8eb4c8f5d44c0726bdda2f52809eb928c44ac57ec41238cac1d60d92cefe87a5970e284998212a53078b05b02fe633fa3a"} build_url:https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/ANSgEGhnR86jtSGXxuKXyA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b254743a5234f6c3da8639ab8dd8058f18b0ca459e4355d0db5884ec907191928cd630e573db3174f4780a280b2b8d251741ac4f8e37ded1ff6fcd831063aac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c16b30bca1c1e3ed2d0467cb94899f11350ac8b9d2359ce7b8a2ac34340ae1ff59a8b3c03ce491be0e177d53b522ea835312d897537138564318788fd35ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f051e77506bcb0c7544bc588ea5eee8eb4c8f5d44c0726bdda2f52809eb928c44ac57ec41238cac1d60d92cefe87a5970e284998212a53078b05b02fe633fa3a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 02:28:42.678033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:28:42.678370) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1471424723.321097-1904205690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:28:42.765979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 02:28:42.766448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 02:28:42.766888) ========= ========= Total master_lag: 0.18 =========