builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1472735921.97 results: success (0) buildid: 20160901053821 builduid: 0dbbe95f11c54603b9f542742e9e69ef revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:41.971267) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:41.971683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:41.972116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:42.369854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:42.372209) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 06:18:42-- 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-09-01 06:18:42 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176093 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:42.595526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:42.595835) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.101357 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:42.710770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:18:42.711242) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cba87d584348ee62004f8d7893529c9b37a6bded --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 cba87d584348ee62004f8d7893529c9b37a6bded --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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 06:18:42,924 truncating revision to first 12 chars 2016-09-01 06:18:42,924 Setting DEBUG logging. 2016-09-01 06:18:42,924 attempt 1/10 2016-09-01 06:18:42,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cba87d584348?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 06:18:43,769 unpacking tar archive at: fx-team-cba87d584348/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 06:18:44.156560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:44.156860) ========= script_repo_revision: cba87d584348ee62004f8d7893529c9b37a6bded ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:44.157244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:44.157505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 06:18:44.165354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-09-01 06:18:44.165635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:18:44 INFO - MultiFileLogger online at 20160901 06:18:44 in /builds/slave/test 06:18:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:18:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:44 INFO - {'append_to_log': False, 06:18:44 INFO - 'base_work_dir': '/builds/slave/test', 06:18:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:18:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:44 INFO - 'branch': 'Fx-Team-Non-PGO', 06:18:44 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:44 INFO - 'config_files': ('talos/linux_config.py',), 06:18:44 INFO - 'default_actions': ('clobber', 06:18:44 INFO - 'read-buildbot-config', 06:18:44 INFO - 'download-and-extract', 06:18:44 INFO - 'populate-webroot', 06:18:44 INFO - 'create-virtualenv', 06:18:44 INFO - 'install', 06:18:44 INFO - 'run-tests'), 06:18:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:44 INFO - 'download_minidump_stackwalk': True, 06:18:44 INFO - 'download_symbols': 'ondemand', 06:18:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:44 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:44 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:44 INFO - 'installer_path': 'installer.exe', 06:18:44 INFO - 'log_level': 'info', 06:18:44 INFO - 'log_name': 'talos', 06:18:44 INFO - 'log_to_console': True, 06:18:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:18:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:18:44 INFO - 'opt_config_files': (), 06:18:44 INFO - 'pip_index': False, 06:18:44 INFO - 'sps_profile': False, 06:18:44 INFO - 'sps_profile_interval': 0, 06:18:44 INFO - 'suite': 'dromaeojs', 06:18:44 INFO - 'system_bits': '32', 06:18:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:44 INFO - 'title': 'talos-linux64-ix-011', 06:18:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:44 INFO - 'use_talos_json': True, 06:18:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:44 INFO - 'work_dir': 'build'} 06:18:44 INFO - [mozharness: 2016-09-01 13:18:44.615058Z] Running clobber step. 06:18:44 INFO - Running pre-action listener: _resource_record_pre_action 06:18:44 INFO - Running main action method: clobber 06:18:44 INFO - rmtree: /builds/slave/test/build 06:18:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:45 INFO - Running post-action listener: _resource_record_post_action 06:18:45 INFO - [mozharness: 2016-09-01 13:18:45.790191Z] Finished clobber step (success) 06:18:45 INFO - [mozharness: 2016-09-01 13:18:45.790360Z] Running read-buildbot-config step. 06:18:45 INFO - Running pre-action listener: _resource_record_pre_action 06:18:45 INFO - Running main action method: read_buildbot_config 06:18:45 INFO - Using buildbot properties: 06:18:45 INFO - { 06:18:45 INFO - "project": "", 06:18:45 INFO - "product": "firefox", 06:18:45 INFO - "script_repo_revision": "production", 06:18:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:18:45 INFO - "repository": "", 06:18:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:18:45 INFO - "buildid": "20160901053821", 06:18:45 INFO - "pgo_build": "False", 06:18:45 INFO - "basedir": "/builds/slave/test", 06:18:45 INFO - "buildnumber": 1912, 06:18:45 INFO - "slavename": "talos-linux64-ix-011", 06:18:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:18:45 INFO - "platform": "ubuntu64_hw", 06:18:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:18:45 INFO - "branch": "fx-team", 06:18:45 INFO - "repo_path": "integration/fx-team", 06:18:45 INFO - "revision": "cba87d584348ee62004f8d7893529c9b37a6bded", 06:18:45 INFO - "stage_platform": "linux64", 06:18:45 INFO - "builduid": "0dbbe95f11c54603b9f542742e9e69ef", 06:18:45 INFO - "slavebuilddir": "test" 06:18:45 INFO - } 06:18:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:18:45 INFO - Running post-action listener: _resource_record_post_action 06:18:45 INFO - [mozharness: 2016-09-01 13:18:45.794567Z] Finished read-buildbot-config step (success) 06:18:45 INFO - [mozharness: 2016-09-01 13:18:45.794722Z] Running download-and-extract step. 06:18:45 INFO - Running pre-action listener: _resource_record_pre_action 06:18:45 INFO - Running main action method: download_and_extract 06:18:45 INFO - mkdir: /builds/slave/test/build/tests 06:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:45 INFO - trying https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:46 INFO - Downloaded 1361 bytes. 06:18:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:18:46 INFO - Using the following test package requirements: 06:18:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:18:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'jsshell-linux-x86_64.zip'], 06:18:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:18:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:18:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:46 INFO - trying https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:18:46 INFO - Downloading https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:47 INFO - Downloaded 20335243 bytes. 06:18:47 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 06:18:51 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 06:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:51 INFO - trying https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:18:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:52 INFO - Downloaded 20335243 bytes. 06:18:52 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 06:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:57 INFO - trying https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:58 INFO - Downloaded 14413998 bytes. 06:18:58 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 06:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:58 INFO - trying https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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 06:19:01 INFO - Downloaded 55868607 bytes. 06:19:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:19:01 INFO - mkdir: /builds/slave/test/properties 06:19:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:01 INFO - Contents: 06:19:01 INFO - build_url:https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:19:01 INFO - Running post-action listener: _resource_record_post_action 06:19:01 INFO - Running post-action listener: set_extra_try_arguments 06:19:01 INFO - [mozharness: 2016-09-01 13:19:01.821030Z] Finished download-and-extract step (success) 06:19:01 INFO - [mozharness: 2016-09-01 13:19:01.821259Z] Running populate-webroot step. 06:19:01 INFO - Running pre-action listener: _resource_record_pre_action 06:19:01 INFO - Running main action method: populate_webroot 06:19:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:01 INFO - '--tppagecycles', 06:19:01 INFO - '7'], 06:19:01 INFO - 'tests': ['tsvgm']}}, 06:19:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:19:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:19:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:19:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['damp', 'tps']}, 06:19:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'tests': ['damp', 'tps']}, 06:19:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['dromaeo_dom']}, 06:19:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['basic_compositor_video']}, 06:19:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:19:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['a11yr', 06:19:01 INFO - 'ts_paint', 06:19:01 INFO - 'tpaint', 06:19:01 INFO - 'sessionrestore', 06:19:01 INFO - 'sessionrestore_no_auto_restore', 06:19:01 INFO - 'tabpaint']}, 06:19:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['tsvgx', 06:19:01 INFO - 'tsvgr_opacity', 06:19:01 INFO - 'tart', 06:19:01 INFO - 'tscrollx', 06:19:01 INFO - 'cart']}, 06:19:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:19:01 INFO - 'tsvgr_opacity', 06:19:01 INFO - 'tart', 06:19:01 INFO - 'tscrollx', 06:19:01 INFO - 'cart']}, 06:19:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'talos_options': ['--disable-e10s'], 06:19:01 INFO - 'tests': ['tp5o']}, 06:19:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'tests': ['tp5o']}, 06:19:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'talos_options': ['--disable-e10s', 06:19:01 INFO - '--xperf_path', 06:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:01 INFO - 'tests': ['tp5n']}, 06:19:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:01 INFO - 'talos_options': ['--xperf_path', 06:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:01 INFO - 'tests': ['tp5n']}}, 06:19:01 INFO - 'talos.zip': {'path': '', 06:19:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:01 INFO - Running post-action listener: _resource_record_post_action 06:19:01 INFO - [mozharness: 2016-09-01 13:19:01.842318Z] Finished populate-webroot step (success) 06:19:01 INFO - [mozharness: 2016-09-01 13:19:01.842408Z] Running create-virtualenv step. 06:19:01 INFO - Running pre-action listener: _resource_record_pre_action 06:19:01 INFO - Running main action method: create_virtualenv 06:19:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:01 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 06:19:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:02 INFO - Using real prefix '/usr' 06:19:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:04 INFO - Installing pip.................done. 06:19:04 INFO - Return code: 0 06:19:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:04 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 06:19:04 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 06:19:04 INFO - Using env: {'DISPLAY': ':0', 06:19:04 INFO - 'HOME': '/home/cltbld', 06:19:04 INFO - 'LANG': 'en_US.UTF-8', 06:19:04 INFO - 'LANGUAGE': 'en_US:en', 06:19:04 INFO - 'LOGNAME': 'cltbld', 06:19:04 INFO - 'MAIL': '/var/mail/cltbld', 06:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:04 INFO - 'MOZ_NO_REMOTE': '1', 06:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:04 INFO - 'NO_EM_RESTART': '1', 06:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:04 INFO - 'PWD': '/builds/slave/test', 06:19:04 INFO - 'SHELL': '/bin/bash', 06:19:04 INFO - 'SHLVL': '1', 06:19:04 INFO - 'TERM': 'linux', 06:19:04 INFO - 'TMOUT': '86400', 06:19:04 INFO - 'USER': 'cltbld', 06:19:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:04 INFO - '_': '/tools/buildbot/bin/python'} 06:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:05 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 06:19:05 INFO - Cleaning up... 06:19:05 INFO - Return code: 0 06:19:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:19:05 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')]} 06:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:05 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')]} 06:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:05 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:05 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 06:19:05 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 06:19:05 INFO - Using env: {'DISPLAY': ':0', 06:19:05 INFO - 'HOME': '/home/cltbld', 06:19:05 INFO - 'LANG': 'en_US.UTF-8', 06:19:05 INFO - 'LANGUAGE': 'en_US:en', 06:19:05 INFO - 'LOGNAME': 'cltbld', 06:19:05 INFO - 'MAIL': '/var/mail/cltbld', 06:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:05 INFO - 'MOZ_NO_REMOTE': '1', 06:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:05 INFO - 'NO_EM_RESTART': '1', 06:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:05 INFO - 'PWD': '/builds/slave/test', 06:19:05 INFO - 'SHELL': '/bin/bash', 06:19:05 INFO - 'SHLVL': '1', 06:19:05 INFO - 'TERM': 'linux', 06:19:05 INFO - 'TMOUT': '86400', 06:19:05 INFO - 'USER': 'cltbld', 06:19:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:05 INFO - '_': '/tools/buildbot/bin/python'} 06:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:05 INFO - Downloading/unpacking psutil>=3.1.1 06:19:05 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 06:19:05 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 06:19:05 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 06:19:05 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 06:19:05 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 06:19:05 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 06:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:07 INFO - Installing collected packages: psutil 06:19:07 INFO - Running setup.py install for psutil 06:19:07 INFO - building 'psutil._psutil_linux' extension 06:19:07 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 06:19:08 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 06:19:08 INFO - building 'psutil._psutil_posix' extension 06:19:08 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 06:19:09 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 06:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:09 INFO - Successfully installed psutil 06:19:09 INFO - Cleaning up... 06:19:09 INFO - Return code: 0 06:19:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:19:09 INFO - Using env: {'DISPLAY': ':0', 06:19:09 INFO - 'HOME': '/home/cltbld', 06:19:09 INFO - 'LANG': 'en_US.UTF-8', 06:19:09 INFO - 'LANGUAGE': 'en_US:en', 06:19:09 INFO - 'LOGNAME': 'cltbld', 06:19:09 INFO - 'MAIL': '/var/mail/cltbld', 06:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:09 INFO - 'MOZ_NO_REMOTE': '1', 06:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:09 INFO - 'NO_EM_RESTART': '1', 06:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:09 INFO - 'PWD': '/builds/slave/test', 06:19:09 INFO - 'SHELL': '/bin/bash', 06:19:09 INFO - 'SHLVL': '1', 06:19:09 INFO - 'TERM': 'linux', 06:19:09 INFO - 'TMOUT': '86400', 06:19:09 INFO - 'USER': 'cltbld', 06:19:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:09 INFO - '_': '/tools/buildbot/bin/python'} 06:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:19:09 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 06:19:09 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 06:19:09 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 06:19:09 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 06:19:09 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 06:19:09 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 06:19:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:19:11 INFO - Installing collected packages: mozsystemmonitor 06:19:11 INFO - Running setup.py install for mozsystemmonitor 06:19:11 INFO - Successfully installed mozsystemmonitor 06:19:11 INFO - Cleaning up... 06:19:11 INFO - Return code: 0 06:19:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:11 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:11 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 06:19:11 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 06:19:11 INFO - Using env: {'DISPLAY': ':0', 06:19:11 INFO - 'HOME': '/home/cltbld', 06:19:11 INFO - 'LANG': 'en_US.UTF-8', 06:19:11 INFO - 'LANGUAGE': 'en_US:en', 06:19:11 INFO - 'LOGNAME': 'cltbld', 06:19:11 INFO - 'MAIL': '/var/mail/cltbld', 06:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:11 INFO - 'MOZ_NO_REMOTE': '1', 06:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:11 INFO - 'NO_EM_RESTART': '1', 06:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:11 INFO - 'PWD': '/builds/slave/test', 06:19:11 INFO - 'SHELL': '/bin/bash', 06:19:11 INFO - 'SHLVL': '1', 06:19:11 INFO - 'TERM': 'linux', 06:19:11 INFO - 'TMOUT': '86400', 06:19:11 INFO - 'USER': 'cltbld', 06:19:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:11 INFO - '_': '/tools/buildbot/bin/python'} 06:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:11 INFO - Downloading/unpacking jsonschema==2.5.1 06:19:11 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 06:19:11 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 06:19:11 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 06:19:11 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 06:19:11 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 06:19:11 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 06:19:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:19:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - Downloading functools32-3.2.3-2.tar.gz 06:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:19:14 INFO - warning: no files found matching '*.txt' 06:19:14 INFO - no previously-included directories found matching 'build' 06:19:14 INFO - no previously-included directories found matching 'dist' 06:19:14 INFO - no previously-included directories found matching '.git*' 06:19:14 INFO - Installing collected packages: jsonschema, functools32 06:19:14 INFO - Running setup.py install for functools32 06:19:14 INFO - warning: no files found matching '*.txt' 06:19:14 INFO - no previously-included directories found matching 'build' 06:19:14 INFO - no previously-included directories found matching 'dist' 06:19:14 INFO - no previously-included directories found matching '.git*' 06:19:14 INFO - Successfully installed jsonschema functools32 06:19:14 INFO - Cleaning up... 06:19:14 INFO - Return code: 0 06:19:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:19:14 INFO - Using env: {'DISPLAY': ':0', 06:19:14 INFO - 'HOME': '/home/cltbld', 06:19:14 INFO - 'LANG': 'en_US.UTF-8', 06:19:14 INFO - 'LANGUAGE': 'en_US:en', 06:19:14 INFO - 'LOGNAME': 'cltbld', 06:19:14 INFO - 'MAIL': '/var/mail/cltbld', 06:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:14 INFO - 'MOZ_NO_REMOTE': '1', 06:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:14 INFO - 'NO_EM_RESTART': '1', 06:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:14 INFO - 'PWD': '/builds/slave/test', 06:19:14 INFO - 'SHELL': '/bin/bash', 06:19:14 INFO - 'SHLVL': '1', 06:19:14 INFO - 'TERM': 'linux', 06:19:14 INFO - 'TMOUT': '86400', 06:19:14 INFO - 'USER': 'cltbld', 06:19:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:14 INFO - '_': '/tools/buildbot/bin/python'} 06:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:19:14 INFO - Cleaning up... 06:19:14 INFO - Return code: 0 06:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:19:14 INFO - Using env: {'DISPLAY': ':0', 06:19:14 INFO - 'HOME': '/home/cltbld', 06:19:14 INFO - 'LANG': 'en_US.UTF-8', 06:19:14 INFO - 'LANGUAGE': 'en_US:en', 06:19:14 INFO - 'LOGNAME': 'cltbld', 06:19:14 INFO - 'MAIL': '/var/mail/cltbld', 06:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:14 INFO - 'MOZ_NO_REMOTE': '1', 06:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:14 INFO - 'NO_EM_RESTART': '1', 06:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:14 INFO - 'PWD': '/builds/slave/test', 06:19:14 INFO - 'SHELL': '/bin/bash', 06:19:14 INFO - 'SHLVL': '1', 06:19:14 INFO - 'TERM': 'linux', 06:19:14 INFO - 'TMOUT': '86400', 06:19:14 INFO - 'USER': 'cltbld', 06:19:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:14 INFO - '_': '/tools/buildbot/bin/python'} 06:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:16 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19:16 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 06:19:16 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 06:19:16 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 06:19:16 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 06:19:16 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 06:19:16 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 06:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:17 INFO - Downloading docopt-0.6.1.tar.gz 06:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:17 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:17 INFO - Running setup.py install for blobuploader 06:19:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:17 INFO - Running setup.py install for requests 06:19:17 INFO - Running setup.py install for docopt 06:19:17 INFO - Successfully installed blobuploader requests docopt 06:19:17 INFO - Cleaning up... 06:19:17 INFO - Return code: 0 06:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:17 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:17 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 06:19:17 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 06:19:17 INFO - Using env: {'DISPLAY': ':0', 06:19:17 INFO - 'HOME': '/home/cltbld', 06:19:17 INFO - 'LANG': 'en_US.UTF-8', 06:19:17 INFO - 'LANGUAGE': 'en_US:en', 06:19:17 INFO - 'LOGNAME': 'cltbld', 06:19:17 INFO - 'MAIL': '/var/mail/cltbld', 06:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:17 INFO - 'MOZ_NO_REMOTE': '1', 06:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:17 INFO - 'NO_EM_RESTART': '1', 06:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:17 INFO - 'PWD': '/builds/slave/test', 06:19:17 INFO - 'SHELL': '/bin/bash', 06:19:17 INFO - 'SHLVL': '1', 06:19:17 INFO - 'TERM': 'linux', 06:19:17 INFO - 'TMOUT': '86400', 06:19:17 INFO - 'USER': 'cltbld', 06:19:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:17 INFO - '_': '/tools/buildbot/bin/python'} 06:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:18 INFO - Running setup.py (path:/tmp/pip-M2tETl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:18 INFO - Running setup.py (path:/tmp/pip-ITbD17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:18 INFO - Running setup.py (path:/tmp/pip-L2dozR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:18 INFO - Running setup.py (path:/tmp/pip-tdLBHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:18 INFO - Running setup.py (path:/tmp/pip-89rsJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:18 INFO - Running setup.py (path:/tmp/pip-HOH57V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:18 INFO - Running setup.py (path:/tmp/pip-zC02st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:18 INFO - Running setup.py (path:/tmp/pip-WPoxsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:18 INFO - Running setup.py (path:/tmp/pip-OQjKaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:18 INFO - Running setup.py (path:/tmp/pip-RM_Pxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:18 INFO - Running setup.py (path:/tmp/pip-CFNdk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:18 INFO - Running setup.py (path:/tmp/pip-ipFd5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:19 INFO - Running setup.py (path:/tmp/pip-BzaNcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:19 INFO - Running setup.py (path:/tmp/pip-H458Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:19 INFO - Running setup.py (path:/tmp/pip-n9gFxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:19 INFO - Running setup.py (path:/tmp/pip-eEFbyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:19 INFO - Running setup.py (path:/tmp/pip-u5UDxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:19 INFO - Running setup.py install for manifestparser 06:19:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:19 INFO - Running setup.py install for mozcrash 06:19:19 INFO - Running setup.py install for mozdebug 06:19:19 INFO - Running setup.py install for mozdevice 06:19:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:19 INFO - Running setup.py install for mozfile 06:19:19 INFO - Running setup.py install for mozhttpd 06:19:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:19 INFO - Running setup.py install for mozinfo 06:19:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for mozInstall 06:19:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for mozleak 06:19:20 INFO - Running setup.py install for mozlog 06:19:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for moznetwork 06:19:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for mozprocess 06:19:20 INFO - Running setup.py install for mozprofile 06:19:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for mozrunner 06:19:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:20 INFO - Running setup.py install for mozscreenshot 06:19:20 INFO - Running setup.py install for moztest 06:19:21 INFO - Running setup.py install for mozversion 06:19:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:21 INFO - Cleaning up... 06:19:21 INFO - Return code: 0 06:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:21 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')]} 06:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:21 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')]} 06:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:21 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:21 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 06:19:21 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 06:19:21 INFO - Using env: {'DISPLAY': ':0', 06:19:21 INFO - 'HOME': '/home/cltbld', 06:19:21 INFO - 'LANG': 'en_US.UTF-8', 06:19:21 INFO - 'LANGUAGE': 'en_US:en', 06:19:21 INFO - 'LOGNAME': 'cltbld', 06:19:21 INFO - 'MAIL': '/var/mail/cltbld', 06:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:21 INFO - 'MOZ_NO_REMOTE': '1', 06:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:21 INFO - 'NO_EM_RESTART': '1', 06:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:21 INFO - 'PWD': '/builds/slave/test', 06:19:21 INFO - 'SHELL': '/bin/bash', 06:19:21 INFO - 'SHLVL': '1', 06:19:21 INFO - 'TERM': 'linux', 06:19:21 INFO - 'TMOUT': '86400', 06:19:21 INFO - 'USER': 'cltbld', 06:19:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:21 INFO - '_': '/tools/buildbot/bin/python'} 06:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:21 INFO - Running setup.py (path:/tmp/pip-SzNil6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:21 INFO - Running setup.py (path:/tmp/pip-KxW3pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:21 INFO - Running setup.py (path:/tmp/pip-NTuTvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:21 INFO - Running setup.py (path:/tmp/pip-RvNTJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:21 INFO - Running setup.py (path:/tmp/pip-uITuta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:21 INFO - Running setup.py (path:/tmp/pip-vXjsk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:21 INFO - Running setup.py (path:/tmp/pip-9F2YHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:21 INFO - Running setup.py (path:/tmp/pip-XJquA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:21 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)) 06:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:21 INFO - Running setup.py (path:/tmp/pip-mVhjTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:22 INFO - Running setup.py (path:/tmp/pip-3t4qpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:22 INFO - Running setup.py (path:/tmp/pip-3WTv59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:22 INFO - Running setup.py (path:/tmp/pip-ozwSQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:22 INFO - Running setup.py (path:/tmp/pip-ITK9NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:22 INFO - Running setup.py (path:/tmp/pip-rMYVH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:22 INFO - Running setup.py (path:/tmp/pip-bA8CdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:22 INFO - Running setup.py (path:/tmp/pip-DqZNMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:22 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)) 06:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:22 INFO - Running setup.py (path:/tmp/pip-Mxt5Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:22 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)) 06:19:22 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)) 06:19:22 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)) 06:19:22 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)) 06:19:22 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)) 06:19:22 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)) 06:19:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:24 INFO - Downloading blessings-1.6.tar.gz 06:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:24 INFO - Installing collected packages: blessings 06:19:24 INFO - Running setup.py install for blessings 06:19:24 INFO - Successfully installed blessings 06:19:24 INFO - Cleaning up... 06:19:24 INFO - Return code: 0 06:19:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:24 INFO - Reading from file tmpfile_stdout 06:19:24 INFO - Current package versions: 06:19:24 INFO - argparse == 1.2.1 06:19:24 INFO - blessings == 1.6 06:19:24 INFO - blobuploader == 1.2.4 06:19:24 INFO - docopt == 0.6.1 06:19:24 INFO - functools32 == 3.2.3-2 06:19:24 INFO - jsonschema == 2.5.1 06:19:24 INFO - manifestparser == 1.1 06:19:24 INFO - mozInstall == 1.12 06:19:24 INFO - mozcrash == 0.17 06:19:24 INFO - mozdebug == 0.1 06:19:24 INFO - mozdevice == 0.48 06:19:24 INFO - mozfile == 1.2 06:19:24 INFO - mozhttpd == 0.7 06:19:24 INFO - mozinfo == 0.9 06:19:24 INFO - mozleak == 0.1 06:19:24 INFO - mozlog == 3.3 06:19:24 INFO - moznetwork == 0.27 06:19:24 INFO - mozprocess == 0.23 06:19:24 INFO - mozprofile == 0.28 06:19:24 INFO - mozrunner == 6.12 06:19:24 INFO - mozscreenshot == 0.1 06:19:24 INFO - mozsystemmonitor == 0.3 06:19:24 INFO - moztest == 0.7 06:19:24 INFO - mozversion == 1.4 06:19:24 INFO - psutil == 3.1.1 06:19:24 INFO - requests == 1.2.3 06:19:24 INFO - wsgiref == 0.1.2 06:19:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:24 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 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19:24 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 06:19:24 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 06:19:24 INFO - Using env: {'DISPLAY': ':0', 06:19:24 INFO - 'HOME': '/home/cltbld', 06:19:24 INFO - 'LANG': 'en_US.UTF-8', 06:19:24 INFO - 'LANGUAGE': 'en_US:en', 06:19:24 INFO - 'LOGNAME': 'cltbld', 06:19:24 INFO - 'MAIL': '/var/mail/cltbld', 06:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:24 INFO - 'MOZ_NO_REMOTE': '1', 06:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:24 INFO - 'NO_EM_RESTART': '1', 06:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:24 INFO - 'PWD': '/builds/slave/test', 06:19:24 INFO - 'SHELL': '/bin/bash', 06:19:24 INFO - 'SHLVL': '1', 06:19:24 INFO - 'TERM': 'linux', 06:19:24 INFO - 'TMOUT': '86400', 06:19:24 INFO - 'USER': 'cltbld', 06:19:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:24 INFO - '_': '/tools/buildbot/bin/python'} 06:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 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)) 06:19:25 INFO - Cleaning up... 06:19:25 INFO - Return code: 0 06:19:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f3294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', '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 06:19: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', 'jsonschema'] in /builds/slave/test/build 06:19: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 jsonschema 06:19:25 INFO - Using env: {'DISPLAY': ':0', 06:19:25 INFO - 'HOME': '/home/cltbld', 06:19:25 INFO - 'LANG': 'en_US.UTF-8', 06:19:25 INFO - 'LANGUAGE': 'en_US:en', 06:19:25 INFO - 'LOGNAME': 'cltbld', 06:19:25 INFO - 'MAIL': '/var/mail/cltbld', 06:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:25 INFO - 'MOZ_NO_REMOTE': '1', 06:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:25 INFO - 'NO_EM_RESTART': '1', 06:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:25 INFO - 'PWD': '/builds/slave/test', 06:19:25 INFO - 'SHELL': '/bin/bash', 06:19:25 INFO - 'SHLVL': '1', 06:19:25 INFO - 'TERM': 'linux', 06:19:25 INFO - 'TMOUT': '86400', 06:19:25 INFO - 'USER': 'cltbld', 06:19:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:25 INFO - '_': '/tools/buildbot/bin/python'} 06:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:19:25 INFO - Cleaning up... 06:19:25 INFO - Return code: 0 06:19:25 INFO - Running post-action listener: _resource_record_post_action 06:19:25 INFO - Running post-action listener: _start_resource_monitoring 06:19:25 INFO - Starting resource monitoring. 06:19:25 INFO - [mozharness: 2016-09-01 13:19:25.462542Z] Finished create-virtualenv step (success) 06:19:25 INFO - [mozharness: 2016-09-01 13:19:25.463537Z] Running install step. 06:19:25 INFO - Running pre-action listener: _resource_record_pre_action 06:19:25 INFO - Running main action method: install 06:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:25 INFO - Reading from file tmpfile_stdout 06:19:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:19:25 INFO - Reading from file tmpfile_stdout 06:19:25 INFO - Output received: 06:19:25 INFO - Usage: mozinstall [options] installer 06:19:25 INFO - Options: 06:19:25 INFO - -h, --help show this help message and exit 06:19:25 INFO - -d DEST, --destination=DEST 06:19:25 INFO - Directory to install application into. [default: 06:19:25 INFO - "/builds/slave/test"] 06:19:25 INFO - --app=APP Application being installed. [default: firefox] 06:19:25 INFO - mkdir: /builds/slave/test/build/application 06:19:25 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'] 06:19:25 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 06:19:41 INFO - Reading from file tmpfile_stdout 06:19:41 INFO - Output received: 06:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:19:41 INFO - Running post-action listener: _resource_record_post_action 06:19:41 INFO - [mozharness: 2016-09-01 13:19:41.883070Z] Finished install step (success) 06:19:41 INFO - [mozharness: 2016-09-01 13:19:41.883357Z] Running run-tests step. 06:19:41 INFO - Running pre-action listener: _resource_record_pre_action 06:19:41 INFO - Running main action method: run_tests 06:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:41 INFO - Python 2.7.3 06:19:41 INFO - Return code: 0 06:19:41 INFO - grabbing minidump binary from tooltool 06:19: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')]} 06:19:41 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 0x1485090>, '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 0x14889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1488e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:41 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 06:19:41 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 06:19:41 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 06:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:42 INFO - Return code: 0 06:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 06:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 06:19:42 INFO - Using env: {'DISPLAY': ':0', 06:19:42 INFO - 'HOME': '/home/cltbld', 06:19:42 INFO - 'LANG': 'en_US.UTF-8', 06:19:42 INFO - 'LANGUAGE': 'en_US:en', 06:19:42 INFO - 'LOGNAME': 'cltbld', 06:19:42 INFO - 'MAIL': '/var/mail/cltbld', 06:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:42 INFO - 'MOZ_NO_REMOTE': '1', 06:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:42 INFO - 'NO_EM_RESTART': '1', 06:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:42 INFO - 'PWD': '/builds/slave/test', 06:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:42 INFO - 'SHELL': '/bin/bash', 06:19:42 INFO - 'SHLVL': '1', 06:19:42 INFO - 'TERM': 'linux', 06:19:42 INFO - 'TMOUT': '86400', 06:19:42 INFO - 'USER': 'cltbld', 06:19:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057', 06:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:42 INFO - '_': '/tools/buildbot/bin/python'} 06:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 06:19:42 INFO - mozversion application_buildid: 20160901053821 06:19:42 INFO - mozversion application_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 06:19:42 INFO - mozversion application_display_name: Nightly 06:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:42 INFO - mozversion application_name: Firefox 06:19:42 INFO - mozversion application_remotingname: firefox 06:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:19:42 INFO - mozversion application_vendor: Mozilla 06:19:42 INFO - mozversion application_version: 51.0a1 06:19:42 INFO - mozversion platform_buildid: 20160901053821 06:19:42 INFO - mozversion platform_changeset: cba87d584348ee62004f8d7893529c9b37a6bded 06:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:19:42 INFO - mozversion platform_version: 51.0a1 06:19:42 INFO - using testdate: 1472735982 06:19:42 INFO - actual date: 1472735982 06:19:42 INFO - starting webserver on 'localhost:44895' 06:19:42 INFO - SUITE-START | Running 2 tests 06:19:42 INFO - TEST-START | dromaeo_css 06:19:42 INFO - operating with platform_type : linux_ 06:19:42 INFO - Initialising browser for dromaeo_css test... 06:19:42 INFO - TEST-INFO | started process 3348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWdfpIJ/profile http://localhost:44895/getInfo.html) 06:19:53 INFO - PROCESS | 3348 | __metrics Screen width/height:1600/1200 06:19:53 INFO - PROCESS | 3348 | colorDepth:24 06:19:53 INFO - PROCESS | 3348 | Browser inner width/height: 1024/697 06:19:53 INFO - PROCESS | 3348 | __metrics 06:19:54 INFO - PROCESS | 3348 | 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" 06:19:54 INFO - PROCESS | 3348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:54 INFO - PROCESS | 3348 | console.error: PushService: 06:19:54 INFO - PROCESS | 3348 | stateChangeProcessEnqueue: Error transitioning state 06:19:54 INFO - PROCESS | 3348 | UnknownError 06:19:55 INFO - TEST-INFO | 3348: exit 0 06:19:55 INFO - Browser initialized. 06:19:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:55 INFO - TEST-INFO | started process 3430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWdfpIJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:07 INFO - PROCESS | 3430 | RSS: Main: 181604352 06:20:07 INFO - PROCESS | 3430 | 06:20:58 INFO - PROCESS | 3430 | 1472736058911 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] 06:23:13 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44895/tests/dromaeo/cssquery-ext.html) 06:23:14 INFO - PROCESS | 3430 | RSS: Main: 275292160 06:23:14 INFO - PROCESS | 3430 | 06:26:16 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-ext.html (next: http://localhost:44895/tests/dromaeo/cssquery-jquery.html) 06:26:17 INFO - PROCESS | 3430 | RSS: Main: 271290368 06:26:17 INFO - PROCESS | 3430 | 06:29:19 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44895/tests/dromaeo/cssquery-mootools.html) 06:29:20 INFO - PROCESS | 3430 | RSS: Main: 254328832 06:29:20 INFO - PROCESS | 3430 | 06:32:22 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44895/tests/dromaeo/cssquery-prototype.html) 06:32:23 INFO - PROCESS | 3430 | RSS: Main: 220262400 06:32:23 INFO - PROCESS | 3430 | 06:35:26 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44895/tests/dromaeo/cssquery-yui.html) 06:35:27 INFO - PROCESS | 3430 | RSS: Main: 219893760 06:35:27 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:44895/tests/dromaeo/cssquery-yui.html (next: http://localhost:44895/tests/dromaeo/cssquery-dojo.html) 06:38:30 INFO - PROCESS | 3430 | RSS: Main: 281190400 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | __start_tp_report 06:38:30 INFO - PROCESS | 3430 | _x_x_mozilla_page_load 06:38:30 INFO - PROCESS | 3430 | _x_x_mozilla_page_load_details 06:38:30 INFO - PROCESS | 3430 | |i|pagename|runs| 06:38:30 INFO - PROCESS | 3430 | |0;dojo.html;2599.8830052647627;2602.6746656667915;2615.241579941817;2642.828216165949;2667.973320266798;4553.385292985446;4604.033153037866;4628.560286772759;4647.256438969765;4768.928466073012;4584.51862554432;4593.793279302431;4595;4623.907521849569;4649.674522783406;4241.2365774160635;4258.276093064171;4326.394304797331;4356.4990026146925;4405.383246345515;4282.528921818597;4285.721428107178;4288;4293.184294983958;4337.240982827992;4213.557576454459;4243.066525364415;4249;4255.744655320691;4342.348647702838;4230.91538169238;4246.278132717445;4250.808713607895;4343.04453020335;4361.323994780814;4248.4052232687445;4266.168097221043;4269.850555230583;4282.935755963663;4321.416608757809;4533.138703646297;4688.789004494806;4702.858914232578;4703.764811759433;4708.929366059512;4883.584895283905;4932.876678083041;4944.233643785219;4954.87612809679;4959.454460009432;4956.058348913695;4956.578690811285;4958.826441074581;4960.801567937278;5033.546980771712;4579.290210017452;4587.266037433995;4690.319903613991;4698.530146985274;4710.4347478302825;5008.449070602231;5031.572316353151;5065.037642847848;5087.516685914832;5096.592272618182;4850.587700045536;4889.193283108248;4890;4895.094407534618;4960.627952903546;4765;4908.460069392364;4937.975310123426;4940.382452193476;4995.675281106716;4903.5586797188425;4927;4939.851804445872;4953.851384458472;4964.032013757283;4956.256561515729;4968.776405061781;4971.875703107379;4984.22744474607;5026.723530205801;4179.352200408881;4301.720388174758;4307.8492252771;4309.870703878889;4372.978135109304;3684.907877303035;3735.0475628714503;3786.280606684721;3814.8474061037805;3877.6703980161437;4330.566943305707;4332.653387728974;4335.328024156261;4343.2399330117105;4393.780310984438;5060.84817455477;5084.084864724385;5085.211792172219;5085.338905942203;5146.0479811235045;4199.097194103282;4247.49030116388;4265.616094551505;4270.210011147948;4322.135572885435;4534.251848444969;4535.591796738309;4575.359449677047;4579.816807327737;4596.080783843245;4637.489876113625;4646.349511068385;4652.6975746577045;4654.483435631531;4701.764911754467;4865.537773911473;4953.23224900141;4973.353464049796;4994.650374473752;5032.773525191448;4635.814567417266;4676.064787042537;4676.625869930465;4719.693219940693;4731.787069581808;4935.777889995031;4940.92588611164;4943.406791184937;4952.479989601185;5005.024020316004;4885.364902562644;4960.082384758831;4998.175301075427;5004.649674522749;5077.238414237894;4848.7090774553635;4860.076585448754;4864.124457597666;4914.066327397783;4926.359573255454;4861.927071094007;4872.585830204473;4875.341828853201;4876.390451193601;4922.975385123052;4637.536246375335;4763.190257656276;4833.468318484894;4869.878253043702;4894.632902532253;4992.15133427311;5011.824586139468;5020.347354843847;5040.294358789699;5074.289599456005;4885.560299572913;4900.975495122501;4907.165781817171;4907.509249075064;4964.35463389757 06:38:30 INFO - PROCESS | 3430 | |1;ext.html;577.1544687033496;589.3487696095817;590.881823635273;591.3111225422383;593.1695626123428;29094.563581546267;30051.54922676159;30083.699163008365;30118.849405752997;30187.547186792217;38033.429498557474;39235.607643923555;39285;42747.717568472915;42874.571254287446;7655.234476552342;7784.1826608206175;7789.493682910621;7793.415493837956;7796.220377962187;7040.436765058783;7714.729984450545;7787.844243115134;7798.064232292105;7803.258690424401;9913.801723965553;10186.59253629854;10194.184465242763;10516.21128415368;10526.105281051081;10049.296549241555;10111.443870587114;10126.848097278547;10129.037741414553;10133.088022077975;9664.081912218327;9711.757206069835;9726.610935562569;9731.41611503312;9737;37226.44160337597;37262;37377.81311093427;37490;37501.62498375009;2796.5385711357603;2889.508783506809;2926.2976885547528;2952.6604440489405;3074;27734;28013.159605211877;28315.00897468579;28389.212099402095;28470.28824279389;3435.9484607730906;3452.361313157074;3467.427874400721;3483.930321393583;3495.94756078659;250936;253354;253478;254078;254562;52509.2123618146;52671.73664131655;52749.472505274454;52885.7355713219;52904;31483.370332593677;32605.18487037843;32727.67272327294;34407.65592344045;34417.65582344194;14894.925525372304;14928.253587320807;14930.925345373204;14938;15061.849381506045;11369.829452558219;11465.197436179387;11545;11545.134114941413;11546.480408381643;11197.216194866443;11574.189806713617;11583.76832463346;17527.123643818013;17684.911575442296;5703.828885133453;6656;6735.124433823669;6891;6952.2352541220425;784.5096814490943;836.481381543447;854.273867212864;861.1431625532636;928.4201946302635;26872.865635671697;27341.589876151873;27347.45305093887;27803.860980695372;27835.103085568036;942.7643089227693;956.7895063086249;986.4032260482448;1002.8545860850281;1053.957841686324;13856.722865542633;14562.635934101732;14637.121772693672;14677.706445871236;14742.875974295224;374282;378264.17358263955;378349;378952;379224;40388.79805600953;45225.321620175724;47018;47328.290075648896;47350;1150.4132892225193;1172.1823306211463;1176.353005846781;1176.7646470705893;1179.4406138679087;26824.731752683005;27717.584236236875;28273.15180544587;28555.143345699664;29145.85427072936;40731.59268407278;41326;41328.38007429951;41342.37986430266;41362.379564307164;311565;311792;428105;431629;437552;36976.445353319185;37146.62853371432;37256.254874902894;37439.251214976095;37735.433968489946;40271.597284026786;40636.1872762549;40834.79582602068;40958.385624215065;41280.58719412767;34645;34759.131021723646;34932.650673493954;35102;35551.11122221862;33818.830905845316;34400;34672.479912801835;34814.303713926085;34818.47772283367;34645.48031779475;34917.650823491436;34927.30145397129;35312.29375412426;35654.643453565135;30721.539176911916;31975.200619983756;32193.839030804695;32263.51604725884;32525.34949301048;24289.51420971606;24560.385990350384;24566.140185093434;25011.374715631526;25182.370440739127 06:38:30 INFO - PROCESS | 3430 | |2;jquery.html;333.4664536741213;334.65530503581306;338.839051450561;341.87524535014876;356.74492737692543;12309.199902006374;15516.456924007647;16170.676586468264;16534.255958481866;17487.91256043718;16423.671526569462;16580.751288730648;16885.409010684627;17118.914405427957;17216.913915430407;4922.729249891255;4960.7767650455635;5037.672551284173;5038.974805125988;5074.238864170367;3641.308151451216;4995.750212489379;5076.543111119999;5080.872978175538;5473;5698.8005419810315;5793.391693872146;5803.071508558632;5805.042168042268;5807.796727114552;5177.326947496839;5396.4333744957;5456.127019676833;5788;5794.159846822208;5359.839204823861;5389.191621256804;5399.623096110506;5400.405955344909;5401.27082843815;11990.280583164951;12164.391780410944;12254.264744115293;12396;12513.186642868184;1827.6710192165406;1927.5181204698824;2030.6547886859269;2059.9485012874648;2329.429289824004;8804.47173169612;9362.765930851716;9381.530923453869;10923.508442120125;13164.736705265937;1648.6290584618484;1703.1228917107699;1704.4886534039863;1768.8319609637065;1788.6959216933024;63767.362326376606;67440.6627966862;68283.3171668287;68333;68411.97382039324;9862.50687465624;9862.556184971694;9980.101790838859;10208.897911020944;10293.588256469657;13791.51729689456;13814.033017688866;13826.792598111037;13836.861631383557;13880.4447822088;7016.92983070173;7312.634368281565;7329.230430804795;7532.54804711719;7594.5063570867715;6958.165020197507;7027.824304392431;7162.3195796400305;7163.606001669854;7210.098737657793;4019.055521952339;4049.271131196413;4140.937885931713;4223.5142958559545;4378.299472084451;1753.815849335827;1801.918913648889;1802.4772815883248;1802.9909850450663;1862.850971922243;682.5188242289174;856.1609622569916;871.7079778274223;892.6920212526668;893.3032234856822;16223.188840557925;16405.097719625534;16493.83506164923;16746.916265418597;17345.7398139028;826.2522417212432;836.9372297077622;842.9114942931027;878.83302172587;898.205088496672;7998.840313115543;9658.179054780423;9871.457069861226;9895.554700038516;9997.150242229347;347621;349546;357628;359070.81858363206;360827;47686.28470572944;69432;70335.64832175807;73049.6347518259;77454.612726936;898.7393655839865;906.4787747045475;936.541094863512;938.333783014054;943.1558754914313;15542.611434714223;15611.219439027776;16247.59381015484;16267.59331016734;16521.752173717163;28612.713872861004;35964.28071438609;37501;37732.811335943145;38135.809320953216;49624.25563616621;51835.74082129565;52093;52703.47296527139;52961;7091.751788687371;7467.402607791472;7602.201768814195;7786.532808031309;7995.760127196193;11441.313521188755;11659.88340116588;11875.643730688093;11892.881071189524;11962.282263064244;9668.516574171123;10191.133753631024;10331.483425828828;10546.26176167661;10621.362718236931;9908.653197138066;9923.40459572428;10520.316179448311;10679.946600266949;10689;9951.601935922483;10151.796964060824;10221.897781022095;10350.32722873041;10406.47967601632;7129.251428599922;7695.692172313269;7753.534787912743;7853.960730196312;8155.9592202040985;8040.597970101355;9380.249580033444;10049.397036177852;10259.589616415558;10497.265191436527 06:38:30 INFO - PROCESS | 3430 | |3;mootools.html;1336.438695747786;1365.385576490579;1433.792100145479;1635.1578936847534;1663.4676903390905;6639.336066393358;7284.8178795530075;7321.707131714738;7866.92133078669;7868.645910934015;7360.558366498014;7701.807454813633;7743.380529557636;7756.883646745303;7757.10793258774;2179.324409433073;2198.3404978506464;2202.41635966469;2206.2719302630094;2216.390492614528;1827.8537716982676;2097.979020209794;2103.1902717453736;2133.434639820449;2203.8126759225484;2116.185268671557;2147.6134295826746;2177.096504950444;2177.2923799765063;2177.923772667957;2093.9895300523553;2098.401955442707;2114.7885211478883;2151.9354419367287;2157.6871353653787;2069.193014724259;2083.020980139347;2087.3842216546004;2090.2266161520333;2096.3082182879766;7708.6916523339;7747.690092396298;7770;7776.261255180749;7781.299683028498;4272.807723652443;4391.704447188087;4440.111977604492;4450.26570615848;4453.821847126111;2765.405437830876;2937.1629085710683;2985.701429857019;2989.058446589339;2999.5350720638335;917.7659696777346;922.9584668689926;938.4088024544561;939.6945992552379;952.7713348796239;10055.195584353161;10074.496275186211;10085;10111.797764044752;10118.089371956487;3984.6812255019527;4065.3495440729935;4115.382692596135;4173.874783756492;4179.247735407595;8501.65993360271;8551.486910785372;8561.357898157663;8566.229039386486;8571.95714021426;4389.714668546534;4392.055708022726;4392.692511524227;4394.143142087326;4397.758123303185;3941.3496773032703;4023.094803669151;4037.1118353962083;4046.676265898721;4051.47330846988;3527.1358517163458;3579.713622910161;3650.908727281839;3656.11709969366;3661.139632186434;1078.9028987391173;1129.6328693174587;1156.1386766858575;1165.1028707894873;1180.4628893853276;630.5775130662468;639.9584027038228;645.0099097884818;719.0759873562447;750.0287128169034;4978.303037574742;5057.974710126426;5085.415177254663;5172.637915345889;5243.973780131075;800.5396896784256;832.1470492744985;835.2900034970348;840.3907167303778;901.0538934119148;3372.426687463088;3402.5236466894653;3458.5330980317335;3508.4737289406285;3508.6666766657127;9203.217726493189;9586;9614.134727874525;9621.951890240503;9625.51872406377;9560.56977436017;9579.323618366758;9580.904190958141;9592.472414017157;9593.28050396223;7094.858102837914;7251;7348.96325518369;7352.448566357544;7364.374028207555;5111.156659151198;5177.352830896138;5188.870278243074;5193.454687257784;5298.6820790751135;8349.749507514784;8392.4544904581;8395.790105247417;8421.536815474963;8460.661573536989;7900.091489478784;8254.215849494289;8255.174482551936;8533.957330213558;8634.179752923463;6205.937940620536;6375.171227740364;6376.872462550816;6379.553431259767;6381.3937675920715;7041.788746337618;7091.432685385053;7122.60825654594;7134.464915131282;7144.535605185646;5415.296011518478;6174.938250617436;6311.211098612674;6343.492520598434;6524.217093948567;6150.04674275488;6254.562180647311;6265;6386.808395748135;6549.4760419167305;6076.726547305293;6082.300535438481;6130.969345153424;6131.233595800525;6136.570440069152;4264.530901600883;4356.869293921188;4455.108978204307;4470.463544374566;4569.771511424482;4503.684742068155;4532.342810292555;4587.793549290357;4607.193741095362;4638.814447422065 06:38:30 INFO - PROCESS | 3430 | |4;prototype.html;295.10730041624083;297.40370557033145;303.1360622226654;303.9057892053462;306.7591940326844;4845.6850304730215;4864.513548645143;4864.659473836833;4890.168671325879;4896.898197905474;4721.3390125382475;4753.429588449391;4835.564799168074;4838.443578988417;4842.128416884968;3563.6258192889695;3638.599754027055;3780.2232950513217;3786.2048969716393;3823.541175058997;3763.41667041609;3768.566614839301;3780.527434070741;3781.3382658034734;3797.582265950757;3711.8100320810718;3722.516072910518;3735.32923959369;3737.8317975691025;3755.6432138946757;3554.3246783111254;3598.5681718193855;3740.1584643455276;3752.43713442983;3766.886993390203;3323.351946370459;3337.6996070353784;3349.3038104326006;3351.463765797461;3362.277110421271;4664.696794708333;4678.6491013174145;4685.758274057377;4687.273472611751;4720.362751028601;4181.728187667792;4297.591728785792;4305.268104422255;4309.482862056542;4310.288802347609;4970.602351811846;4992.929348450713;4997.250412438163;5000.199968005102;5014.949850501484;3666.9083272918124;3677.687396571295;3681.4661874028116;3689.631036896316;3695.113172838526;5124.795008199668;5217.399999000126;5222.973885130588;5230.97384513075;5258.7370631468275;3734.458503516975;3756.887293381203;3758.3986562149926;3768.4535742317757;3769.9057523561582;3784.7350685452307;3788;3808.124131449782;3812.409076593077;3836.290286297044;4321.783910804447;4326.891827704332;4342.544032876565;4342.956570434319;4348.499922508952;4891.1685013547785;4993.975030124826;5000.524950129732;5047.217681259411;5106.514881086291;1299.740051989606;1314.7633425983224;1317.960461186166;1318.3276528970102;1319.808627748971;816.6814942172557;842.0274582856811;846.9364797640202;856.4005196362571;856.5717141429285;4210.473690788652;4316.503602085738;4370.497392799805;4427.247367947457;4451.732896026248;5166.844994650167;5168.9224661630105;5172.27588137661;5177.430482646906;5179.792808287626;4409.8456554021095;4412.955870441255;4434.162136232813;4448.221561226837;4448.243798554254;2596.4287856671504;2725.087095822882;2726.82275652082;2751.380939288644;2763.3782398960075;4797.856064318076;4807.158747219222;4808.543188397097;4816.397950256218;4826.831060912851;5134.12719837621;5279.709615971158;5291.788328466818;5302.09864323066;5313.814016509404;4776.928346074812;4812.855614331575;4837.3311207634015;4842.5157484251995;4857.757112144308;5142.562882155059;5153.201253805666;5173.560247379015;5215.55667768244;5227.686338819683;4846.95153048465;5088.974555127201;5093.159628661229;5093.668911520739;5113.156329205788;4828.275758636232;4843.2250839865455;4854.05345957549;4863.659543831898;4866.586340160984;3625.746197766131;3630.491731157693;3636.30910127075;3669.101070237809;3676.963230367769;5148.845534633967;5258.553022992935;5261.36863576358;5263.315768950165;5265.341832270966;5039;5084.161113416245;5108.284840122312;5112.309838171799;5120.3343565337755;5096.592272618256;5097.796088156432;5103.209002604603;5106.591472682251;5113.948860511347;4872.9512704872495;4911.935236845081;4968;4977.104121258209;5017.222330538772;4861.538153875376;4939.950600493949;5061.544460998528;5077.365329333833;5089.898202036013;4955.876103097307;4960.156773348467;4960.553550180501;4962.6774259673;4963.081829861487 06:38:30 INFO - PROCESS | 3430 | |5;yui.html;579.8405438504413;593.4037439288314;595.988080238395;605.5367643752529;671.2012704881191;11547.13396495262;11934.82097768532;12498.937505312471;12524.123311368185;12548.874511254884;12560.685982850433;12606;12672.366381680926;12685.936570317159;12692.238465692042;590.790269454344;736.834212302233;753.7248904149973;754.7924320811766;755.1655420760063;740.5482655580092;763.8472305538887;765.6784150656738;768.69636493585;771.5910567399259;797.6251161953872;798.5807451088167;799.7480793550042;799.9640016199285;800.2837460472873;633.3856159525253;799.3365506629484;799.4803377804416;799.5122974985254;799.6801279488193;558.1265319774581;574.4026212738746;576.3458474631282;576.4350936082662;576.7606443326015;11210.103191744642;11222.49498772549;11236.943815280953;11253.212275140744;11258.54965801367;11965.820512692317;12199.268043917305;12217.572384966483;12683.302418366986;13416.060875738702;11819.231749936227;12247.326397048158;12341;12519.56181533642;13023.348832558335;4129.938050929209;4134.287221022668;4164.9583504164875;4287.249731297011;4339.522652508222;65992.34007659958;67224.66387668079;67905;68732.65633671799;68750.31249687489;10082.143017843566;10330.431826249629;10457.790844183073;10481.947590262153;10588.205884558689;18272.908635456737;18533.166007529693;18560.443186704422;18570.535736606424;18600.34898778536;6357.347089756697;6394.808155755335;6433;6533.314002029719;6746.392824645805;3650.233450975325;3710.8515659373325;3756.2111956489443;3758.642928921748;3819.1406933440308;2653.6284920111198;2730.1127133681234;2738.274357295318;2739.6849362323187;2740.849253291048;467.25706127257826;471.41309070207126;472.832144588673;478.75344197738195;479.74093989245415;429.7894031924397;434.7521912509839;459.50431345968656;480.8605504403684;491.2067011775956;7240.239774823568;7559.773206803805;7678.155402905676;7849;7908.406869484812;475.2324995132836;493.36848833493184;509.5745052880812;515.1757188498448;528.7567718849373;3368.6799754023327;3425.847130778342;3474.513568100468;3514.7012503937453;3624.0939765058733;71256.64371678213;105034;105702.47148764208;106402;111596;93779;93918;94011;95264;95811.52094239484;79699.60150199212;81127;81552.59223703844;82342.58828705818;82893;6812.795616131524;7142.821429464305;7173.713051477883;7194.100737407824;7243.782686519413;31382.215444614067;38630.6136938627;39404.80297598494;39496.42014319395;42195.7890210547;43030.13939721251;47866.042679145525;60903.69548152231;62249.68875155595;62427.375726243976;11007.119430445706;11014.559417623206;11173.497192626513;11251.831222531504;11501.597444089752;12732.618021459371;12961.870381296067;13324.333783310989;13407.128536645087;13633.863661363259;12299.815502767287;12377.938110309391;12550.49798008106;13029.241281691964;13390.26353550564;12355.62933112008;12358.62924112242;12793.552225672056;13415.932920335335;13644.863551364757;11161;11865.288082715064;11991.160618756603;12202.572909948109;12558.120931534704;9311.487868167045;9694.36986595869;9717.222622190066;9753.658621948198;9824.361416507903;10095.495225238561;10467.319624224401;10507.94746026265;10586.153107751208;10600.522976465923 06:38:30 INFO - PROCESS | 3430 | __end_tp_report 06:38:30 INFO - PROCESS | 3430 | __start_cc_report 06:38:30 INFO - PROCESS | 3430 | _x_x_mozilla_cycle_collect,887 06:38:30 INFO - PROCESS | 3430 | __end_cc_report 06:38:30 INFO - PROCESS | 3430 | __startTimestamp1472737110400__endTimestamp 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | ------- Summary: start ------- 06:38:30 INFO - PROCESS | 3430 | Number of tests: 6 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#0] dojo.html Cycles:165 Average:4618.87 Median:4710.43 stddev:476.38 (10.1%) stddev-sans-first:450.74 06:38:30 INFO - PROCESS | 3430 | Values: 2599.9 2602.7 2615.2 2642.8 2668.0 4553.4 4604.0 4628.6 4647.3 4768.9 4584.5 4593.8 4595.0 4623.9 4649.7 4241.2 4258.3 4326.4 4356.5 4405.4 4282.5 4285.7 4288.0 4293.2 4337.2 4213.6 4243.1 4249.0 4255.7 4342.3 4230.9 4246.3 4250.8 4343.0 4361.3 4248.4 4266.2 4269.9 4282.9 4321.4 4533.1 4688.8 4702.9 4703.8 4708.9 4883.6 4932.9 4944.2 4954.9 4959.5 4956.1 4956.6 4958.8 4960.8 5033.5 4579.3 4587.3 4690.3 4698.5 4710.4 5008.4 5031.6 5065.0 5087.5 5096.6 4850.6 4889.2 4890.0 4895.1 4960.6 4765.0 4908.5 4938.0 4940.4 4995.7 4903.6 4927.0 4939.9 4953.9 4964.0 4956.3 4968.8 4971.9 4984.2 5026.7 4179.4 4301.7 4307.8 4309.9 4373.0 3684.9 3735.0 3786.3 3814.8 3877.7 4330.6 4332.7 4335.3 4343.2 4393.8 5060.8 5084.1 5085.2 5085.3 5146.0 4199.1 4247.5 4265.6 4270.2 4322.1 4534.3 4535.6 4575.4 4579.8 4596.1 4637.5 4646.3 4652.7 4654.5 4701.8 4865.5 4953.2 4973.4 4994.7 5032.8 4635.8 4676.1 4676.6 4719.7 4731.8 4935.8 4940.9 4943.4 4952.5 5005.0 4885.4 4960.1 4998.2 5004.6 5077.2 4848.7 4860.1 4864.1 4914.1 4926.4 4861.9 4872.6 4875.3 4876.4 4923.0 4637.5 4763.2 4833.5 4869.9 4894.6 4992.2 5011.8 5020.3 5040.3 5074.3 4885.6 4901.0 4907.2 4907.5 4964.4 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#1] ext.html Cycles:180 Average:48208.32 Median:34715.81 stddev:91207.25 (262.7%) stddev-sans-first:91393.00 06:38:30 INFO - PROCESS | 3430 | Values: 577.2 589.3 590.9 591.3 593.2 29094.6 30051.5 30083.7 30118.8 30187.5 38033.4 39235.6 39285.0 42747.7 42874.6 7655.2 7784.2 7789.5 7793.4 7796.2 7040.4 7714.7 7787.8 7798.1 7803.3 9913.8 10186.6 10194.2 10516.2 10526.1 10049.3 10111.4 10126.8 10129.0 10133.1 9664.1 9711.8 9726.6 9731.4 9737.0 37226.4 37262.0 37377.8 37490.0 37501.6 2796.5 2889.5 2926.3 2952.7 3074.0 27734.0 28013.2 28315.0 28389.2 28470.3 3435.9 3452.4 3467.4 3483.9 3495.9 250936.0 253354.0 253478.0 254078.0 254562.0 52509.2 52671.7 52749.5 52885.7 52904.0 31483.4 32605.2 32727.7 34407.7 34417.7 14894.9 14928.3 14930.9 14938.0 15061.8 11369.8 11465.2 11545.0 11545.1 11546.5 11197.2 11574.2 11583.8 17527.1 17684.9 5703.8 6656.0 6735.1 6891.0 6952.2 784.5 836.5 854.3 861.1 928.4 26872.9 27341.6 27347.5 27803.9 27835.1 942.8 956.8 986.4 1002.9 1054.0 13856.7 14562.6 14637.1 14677.7 14742.9 374282.0 378264.2 378349.0 378952.0 379224.0 40388.8 45225.3 47018.0 47328.3 47350.0 1150.4 1172.2 1176.4 1176.8 1179.4 26824.7 27717.6 28273.2 28555.1 29145.9 40731.6 41326.0 41328.4 41342.4 41362.4 311565.0 311792.0 428105.0 431629.0 437552.0 36976.4 37146.6 37256.3 37439.3 37735.4 40271.6 40636.2 40834.8 40958.4 41280.6 34645.0 34759.1 34932.7 35102.0 35551.1 33818.8 34400.0 34672.5 34814.3 34818.5 34645.5 34917.7 34927.3 35312.3 35654.6 30721.5 31975.2 32193.8 32263.5 32525.3 24289.5 24560.4 24566.1 25011.4 25182.4 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#2] jquery.html Cycles:180 Average:22765.00 Median:4941.75 stddev:58656.52 (1187.0%) stddev-sans-first:58796.88 06:38:30 INFO - PROCESS | 3430 | Values: 333.5 334.7 338.8 341.9 356.7 12309.2 15516.5 16170.7 16534.3 17487.9 16423.7 16580.8 16885.4 17118.9 17216.9 4922.7 4960.8 5037.7 5039.0 5074.2 3641.3 4995.8 5076.5 5080.9 5473.0 5698.8 5793.4 5803.1 5805.0 5807.8 5177.3 5396.4 5456.1 5788.0 5794.2 5359.8 5389.2 5399.6 5400.4 5401.3 11990.3 12164.4 12254.3 12396.0 12513.2 1827.7 1927.5 2030.7 2059.9 2329.4 8804.5 9362.8 9381.5 10923.5 13164.7 1648.6 1703.1 1704.5 1768.8 1788.7 63767.4 67440.7 68283.3 68333.0 68412.0 9862.5 9862.6 9980.1 10208.9 10293.6 13791.5 13814.0 13826.8 13836.9 13880.4 7016.9 7312.6 7329.2 7532.5 7594.5 6958.2 7027.8 7162.3 7163.6 7210.1 4019.1 4049.3 4140.9 4223.5 4378.3 1753.8 1801.9 1802.5 1803.0 1862.9 682.5 856.2 871.7 892.7 893.3 16223.2 16405.1 16493.8 16746.9 17345.7 826.3 836.9 842.9 878.8 898.2 7998.8 9658.2 9871.5 9895.6 9997.2 347621.0 349546.0 357628.0 359070.8 360827.0 47686.3 69432.0 70335.6 73049.6 77454.6 898.7 906.5 936.5 938.3 943.2 15542.6 15611.2 16247.6 16267.6 16521.8 28612.7 35964.3 37501.0 37732.8 38135.8 49624.3 51835.7 52093.0 52703.5 52961.0 7091.8 7467.4 7602.2 7786.5 7995.8 11441.3 11659.9 11875.6 11892.9 11962.3 9668.5 10191.1 10331.5 10546.3 10621.4 9908.7 9923.4 10520.3 10679.9 10689.0 9951.6 10151.8 10221.9 10350.3 10406.5 7129.3 7695.7 7753.5 7854.0 8156.0 8040.6 9380.2 10049.4 10259.6 10497.3 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#3] mootools.html Cycles:180 Average:4959.69 Median:5183.11 stddev:2756.20 (53.2%) stddev-sans-first:2750.48 06:38:30 INFO - PROCESS | 3430 | Values: 1336.4 1365.4 1433.8 1635.2 1663.5 6639.3 7284.8 7321.7 7866.9 7868.6 7360.6 7701.8 7743.4 7756.9 7757.1 2179.3 2198.3 2202.4 2206.3 2216.4 1827.9 2098.0 2103.2 2133.4 2203.8 2116.2 2147.6 2177.1 2177.3 2177.9 2094.0 2098.4 2114.8 2151.9 2157.7 2069.2 2083.0 2087.4 2090.2 2096.3 7708.7 7747.7 7770.0 7776.3 7781.3 4272.8 4391.7 4440.1 4450.3 4453.8 2765.4 2937.2 2985.7 2989.1 2999.5 917.8 923.0 938.4 939.7 952.8 10055.2 10074.5 10085.0 10111.8 10118.1 3984.7 4065.3 4115.4 4173.9 4179.2 8501.7 8551.5 8561.4 8566.2 8572.0 4389.7 4392.1 4392.7 4394.1 4397.8 3941.3 4023.1 4037.1 4046.7 4051.5 3527.1 3579.7 3650.9 3656.1 3661.1 1078.9 1129.6 1156.1 1165.1 1180.5 630.6 640.0 645.0 719.1 750.0 4978.3 5058.0 5085.4 5172.6 5244.0 800.5 832.1 835.3 840.4 901.1 3372.4 3402.5 3458.5 3508.5 3508.7 9203.2 9586.0 9614.1 9622.0 9625.5 9560.6 9579.3 9580.9 9592.5 9593.3 7094.9 7251.0 7349.0 7352.4 7364.4 5111.2 5177.4 5188.9 5193.5 5298.7 8349.7 8392.5 8395.8 8421.5 8460.7 7900.1 8254.2 8255.2 8534.0 8634.2 6205.9 6375.2 6376.9 6379.6 6381.4 7041.8 7091.4 7122.6 7134.5 7144.5 5415.3 6174.9 6311.2 6343.5 6524.2 6150.0 6254.6 6265.0 6386.8 6549.5 6076.7 6082.3 6131.0 6131.2 6136.6 4264.5 4356.9 4455.1 4470.5 4569.8 4503.7 4532.3 4587.8 4607.2 4638.8 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#4] prototype.html Cycles:180 Average:4189.00 Median:4810.70 stddev:1211.21 (25.2%) stddev-sans-first:1178.82 06:38:30 INFO - PROCESS | 3430 | Values: 295.1 297.4 303.1 303.9 306.8 4845.7 4864.5 4864.7 4890.2 4896.9 4721.3 4753.4 4835.6 4838.4 4842.1 3563.6 3638.6 3780.2 3786.2 3823.5 3763.4 3768.6 3780.5 3781.3 3797.6 3711.8 3722.5 3735.3 3737.8 3755.6 3554.3 3598.6 3740.2 3752.4 3766.9 3323.4 3337.7 3349.3 3351.5 3362.3 4664.7 4678.6 4685.8 4687.3 4720.4 4181.7 4297.6 4305.3 4309.5 4310.3 4970.6 4992.9 4997.3 5000.2 5014.9 3666.9 3677.7 3681.5 3689.6 3695.1 5124.8 5217.4 5223.0 5231.0 5258.7 3734.5 3756.9 3758.4 3768.5 3769.9 3784.7 3788.0 3808.1 3812.4 3836.3 4321.8 4326.9 4342.5 4343.0 4348.5 4891.2 4994.0 5000.5 5047.2 5106.5 1299.7 1314.8 1318.0 1318.3 1319.8 816.7 842.0 846.9 856.4 856.6 4210.5 4316.5 4370.5 4427.2 4451.7 5166.8 5168.9 5172.3 5177.4 5179.8 4409.8 4413.0 4434.2 4448.2 4448.2 2596.4 2725.1 2726.8 2751.4 2763.4 4797.9 4807.2 4808.5 4816.4 4826.8 5134.1 5279.7 5291.8 5302.1 5313.8 4776.9 4812.9 4837.3 4842.5 4857.8 5142.6 5153.2 5173.6 5215.6 5227.7 4847.0 5089.0 5093.2 5093.7 5113.2 4828.3 4843.2 4854.1 4863.7 4866.6 3625.7 3630.5 3636.3 3669.1 3677.0 5148.8 5258.6 5261.4 5263.3 5265.3 5039.0 5084.2 5108.3 5112.3 5120.3 5096.6 5097.8 5103.2 5106.6 5113.9 4873.0 4911.9 4968.0 4977.1 5017.2 4861.5 4940.0 5061.5 5077.4 5089.9 4955.9 4960.2 4960.6 4962.7 4963.1 06:38:30 INFO - PROCESS | 3430 | 06:38:30 INFO - PROCESS | 3430 | [#5] yui.html Cycles:180 Average:18065.89 Median:23180.37 stddev:26748.45 (115.4%) stddev-sans-first:26791.26 06:38:30 INFO - PROCESS | 3430 | Values: 579.8 593.4 596.0 605.5 671.2 11547.1 11934.8 12498.9 12524.1 12548.9 12560.7 12606.0 12672.4 12685.9 12692.2 590.8 736.8 753.7 754.8 755.2 740.5 763.8 765.7 768.7 771.6 797.6 798.6 799.7 800.0 800.3 633.4 799.3 799.5 799.5 799.7 558.1 574.4 576.3 576.4 576.8 11210.1 11222.5 11236.9 11253.2 11258.5 11965.8 12199.3 12217.6 12683.3 13416.1 11819.2 12247.3 12341.0 12519.6 13023.3 4129.9 4134.3 4165.0 4287.2 4339.5 65992.3 67224.7 67905.0 68732.7 68750.3 10082.1 10330.4 10457.8 10481.9 10588.2 18272.9 18533.2 18560.4 18570.5 18600.3 6357.3 6394.8 6433.0 6533.3 6746.4 3650.2 3710.9 3756.2 3758.6 3819.1 2653.6 2730.1 2738.3 2739.7 2740.8 467.3 471.4 472.8 478.8 479.7 429.8 434.8 459.5 480.9 491.2 7240.2 7559.8 7678.2 7849.0 7908.4 475.2 493.4 509.6 515.2 528.8 3368.7 3425.8 3474.5 3514.7 3624.1 71256.6 105034.0 105702.5 106402.0 111596.0 93779.0 93918.0 94011.0 95264.0 95811.5 79699.6 81127.0 81552.6 82342.6 82893.0 6812.8 7142.8 7173.7 7194.1 7243.8 31382.2 38630.6 39404.8 39496.4 42195.8 43030.1 47866.0 60903.7 62249.7 62427.4 11007.1 11014.6 11173.5 11251.8 11501.6 12732.6 12961.9 13324.3 13407.1 13633.9 12299.8 12377.9 12550.5 13029.2 13390.3 12355.6 12358.6 12793.6 13415.9 13644.9 11161.0 11865.3 11991.2 12202.6 12558.1 9311.5 9694.4 9717.2 9753.7 9824.4 10095.5 10467.3 10507.9 10586.2 10600.5 06:38:30 INFO - PROCESS | 3430 | -------- Summary: end -------- 06:38:30 INFO - PROCESS | 3430 | 06:38:31 INFO - TEST-INFO | 3430: exit 0 06:38:31 INFO - TEST-OK | dromaeo_css | took 1128977ms 06:38:31 INFO - TEST-START | kraken 06:38:31 INFO - operating with platform_type : linux_ 06:38:31 INFO - Initialising browser for kraken test... 06:38:31 INFO - TEST-INFO | started process 3732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTviIOh/profile http://localhost:44895/getInfo.html) 06:38:36 INFO - PROCESS | 3732 | __metrics Screen width/height:1600/1200 06:38:36 INFO - PROCESS | 3732 | colorDepth:24 06:38:36 INFO - PROCESS | 3732 | Browser inner width/height: 1024/697 06:38:36 INFO - PROCESS | 3732 | __metrics 06:38:37 INFO - PROCESS | 3732 | 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" 06:38:37 INFO - PROCESS | 3732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:38 INFO - PROCESS | 3732 | console.error: PushService: 06:38:38 INFO - PROCESS | 3732 | stateChangeProcessEnqueue: Error transitioning state 06:38:38 INFO - PROCESS | 3732 | UnknownError 06:38:38 INFO - TEST-INFO | 3732: exit 0 06:38:38 INFO - Browser initialized. 06:38:38 INFO - Running cycle 1/1 for kraken test... 06:38:38 INFO - TEST-INFO | started process 3811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTviIOh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:51 INFO - PROCESS | 3811 | RSS: Main: 182022144 06:38:51 INFO - PROCESS | 3811 | 06:38:53 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44895/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:54 INFO - PROCESS | 3811 | RSS: Main: 235405312 06:38:54 INFO - PROCESS | 3811 | 06:38:57 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44895/tests/kraken/driver.html?testName=audio-dft) 06:38:58 INFO - PROCESS | 3811 | RSS: Main: 226086912 06:38:58 INFO - PROCESS | 3811 | 06:39:01 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44895/tests/kraken/driver.html?testName=audio-fft) 06:39:01 INFO - PROCESS | 3811 | RSS: Main: 304324608 06:39:01 INFO - PROCESS | 3811 | 06:39:04 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44895/tests/kraken/driver.html?testName=audio-oscillator) 06:39:04 INFO - PROCESS | 3811 | RSS: Main: 213258240 06:39:04 INFO - PROCESS | 3811 | 06:39:06 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:39:07 INFO - PROCESS | 3811 | RSS: Main: 214892544 06:39:07 INFO - PROCESS | 3811 | 06:39:10 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44895/tests/kraken/driver.html?testName=imaging-darkroom) 06:39:11 INFO - PROCESS | 3811 | RSS: Main: 253313024 06:39:11 INFO - PROCESS | 3811 | 06:39:14 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44895/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:15 INFO - PROCESS | 3811 | RSS: Main: 247902208 06:39:15 INFO - PROCESS | 3811 | 06:39:18 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44895/tests/kraken/driver.html?testName=json-parse-financial) 06:39:18 INFO - PROCESS | 3811 | RSS: Main: 250740736 06:39:18 INFO - PROCESS | 3811 | 06:39:20 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:39:21 INFO - PROCESS | 3811 | RSS: Main: 214908928 06:39:21 INFO - PROCESS | 3811 | 06:39:23 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:39:23 INFO - PROCESS | 3811 | RSS: Main: 221732864 06:39:23 INFO - PROCESS | 3811 | 06:39:25 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:39:26 INFO - PROCESS | 3811 | RSS: Main: 222695424 06:39:26 INFO - PROCESS | 3811 | 06:39:30 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:39:31 INFO - PROCESS | 3811 | RSS: Main: 224239616 06:39:31 INFO - PROCESS | 3811 | 06:39:33 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:39:34 INFO - PROCESS | 3811 | RSS: Main: 222044160 06:39:34 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44895/tests/kraken/driver.html?testName=ai-astar) 06:39:36 INFO - PROCESS | 3811 | RSS: Main: 273555456 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | __start_tp_report 06:39:36 INFO - PROCESS | 3811 | _x_x_mozilla_page_load 06:39:36 INFO - PROCESS | 3811 | _x_x_mozilla_page_load_details 06:39:36 INFO - PROCESS | 3811 | |i|pagename|runs| 06:39:36 INFO - PROCESS | 3811 | |0;ai-astar;112;113;131;116;113;114;113;114;113;114 06:39:36 INFO - PROCESS | 3811 | |1;audio-beat-detection;147;125;153;186;125;154;145;132;175;128 06:39:36 INFO - PROCESS | 3811 | |2;audio-dft;161;161;163;164;163;163;163;162;163;162 06:39:36 INFO - PROCESS | 3811 | |3;audio-fft;76;76;77;164;76;78;77;76;166;76 06:39:36 INFO - PROCESS | 3811 | |4;audio-oscillator;84;84;146;83;84;83;145;84;83;131 06:39:36 INFO - PROCESS | 3811 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;118 06:39:36 INFO - PROCESS | 3811 | |6;imaging-darkroom;148;149;147;148;147;149;148;147;146;147 06:39:36 INFO - PROCESS | 3811 | |7;imaging-desaturate;95;95;94;95;95;94;96;95;95;95 06:39:36 INFO - PROCESS | 3811 | |8;json-parse-financial;64;64;65;65;65;67;64;65;65;65 06:39:36 INFO - PROCESS | 3811 | |9;json-stringify-tinderbox;67;67;66;66;68;66;66;67;67;67 06:39:36 INFO - PROCESS | 3811 | |10;stanford-crypto-aes;83;83;83;82;82;83;84;83;83;82 06:39:36 INFO - PROCESS | 3811 | |11;stanford-crypto-ccm;136;135;142;134;134;148;136;138;179;137 06:39:36 INFO - PROCESS | 3811 | |12;stanford-crypto-pbkdf2;173;172;177;173;170;170;171;174;169;169 06:39:36 INFO - PROCESS | 3811 | |13;stanford-crypto-sha256-iterative;69;69;72;69;71;69;67;67;66;66 06:39:36 INFO - PROCESS | 3811 | __end_tp_report 06:39:36 INFO - PROCESS | 3811 | __start_cc_report 06:39:36 INFO - PROCESS | 3811 | _x_x_mozilla_cycle_collect,1948 06:39:36 INFO - PROCESS | 3811 | __end_cc_report 06:39:36 INFO - PROCESS | 3811 | __startTimestamp1472737176606__endTimestamp 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | ------- Summary: start ------- 06:39:36 INFO - PROCESS | 3811 | Number of tests: 14 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:5.62 (4.9%) stddev-sans-first:5.83 06:39:36 INFO - PROCESS | 3811 | Values: 112.0 113.0 131.0 116.0 113.0 114.0 113.0 114.0 113.0 114.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.00 stddev:20.94 (14.0%) stddev-sans-first:22.21 06:39:36 INFO - PROCESS | 3811 | Values: 147.0 125.0 153.0 186.0 125.0 154.0 145.0 132.0 175.0 128.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.87 06:39:36 INFO - PROCESS | 3811 | Values: 161.0 161.0 163.0 164.0 163.0 163.0 163.0 162.0 163.0 162.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.32 (49.1%) stddev-sans-first:39.00 06:39:36 INFO - PROCESS | 3811 | Values: 76.0 76.0 77.0 164.0 76.0 78.0 77.0 76.0 166.0 76.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.50 stddev:27.86 (33.4%) stddev-sans-first:28.89 06:39:36 INFO - PROCESS | 3811 | Values: 84.0 84.0 146.0 83.0 84.0 83.0 145.0 84.0 83.0 131.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:39:36 INFO - PROCESS | 3811 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 06:39:36 INFO - PROCESS | 3811 | Values: 148.0 149.0 147.0 148.0 147.0 149.0 148.0 147.0 146.0 147.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:39:36 INFO - PROCESS | 3811 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 06:39:36 INFO - PROCESS | 3811 | Values: 64.0 64.0 65.0 65.0 65.0 67.0 64.0 65.0 65.0 65.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:39:36 INFO - PROCESS | 3811 | Values: 67.0 67.0 66.0 66.0 68.0 66.0 66.0 67.0 67.0 67.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 06:39:36 INFO - PROCESS | 3811 | Values: 83.0 83.0 83.0 82.0 82.0 83.0 84.0 83.0 83.0 82.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:137.50 stddev:13.72 (10.0%) stddev-sans-first:14.39 06:39:36 INFO - PROCESS | 3811 | Values: 136.0 135.0 142.0 134.0 134.0 148.0 136.0 138.0 179.0 137.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.50 stddev:2.53 (1.5%) stddev-sans-first:2.65 06:39:36 INFO - PROCESS | 3811 | Values: 173.0 172.0 177.0 173.0 170.0 170.0 171.0 174.0 169.0 169.0 06:39:36 INFO - PROCESS | 3811 | 06:39:36 INFO - PROCESS | 3811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:2.01 (2.9%) stddev-sans-first:2.13 06:39:36 INFO - PROCESS | 3811 | Values: 69.0 69.0 72.0 69.0 71.0 69.0 67.0 67.0 66.0 66.0 06:39:36 INFO - PROCESS | 3811 | -------- Summary: end -------- 06:39:36 INFO - PROCESS | 3811 | 06:39:37 INFO - TEST-INFO | 3811: exit 0 06:39:37 INFO - TEST-OK | kraken | took 66667ms 06:39:37 INFO - SUITE-END | took 1195s 06:39:38 INFO - Completed test suite (00:19:55) 06:39:38 INFO - javascript benchmark 06:39:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.8830052647627, 2602.6746656667915, 2615.241579941817, 2642.828216165949, 2667.973320266798, 4553.385292985446, 4604.033153037866, 4628.560286772759, 4647.256438969765, 4768.928466073012, 4584.51862554432, 4593.793279302431, 4595.0, 4623.907521849569, 4649.674522783406, 4241.2365774160635, 4258.276093064171, 4326.394304797331, 4356.4990026146925, 4405.383246345515, 4282.528921818597, 4285.721428107178, 4288.0, 4293.184294983958, 4337.240982827992, 4213.557576454459, 4243.066525364415, 4249.0, 4255.744655320691, 4342.348647702838, 4230.91538169238, 4246.278132717445, 4250.808713607895, 4343.04453020335, 4361.323994780814, 4248.4052232687445, 4266.168097221043, 4269.850555230583, 4282.935755963663, 4321.416608757809, 4533.138703646297, 4688.789004494806, 4702.858914232578, 4703.764811759433, 4708.929366059512, 4883.584895283905, 4932.876678083041, 4944.233643785219, 4954.87612809679, 4959.454460009432, 4956.058348913695, 4956.578690811285, 4958.826441074581, 4960.801567937278, 5033.546980771712, 4579.290210017452, 4587.266037433995, 4690.319903613991, 4698.530146985274, 4710.4347478302825, 5008.449070602231, 5031.572316353151, 5065.037642847848, 5087.516685914832, 5096.592272618182, 4850.587700045536, 4889.193283108248, 4890.0, 4895.094407534618, 4960.627952903546, 4765.0, 4908.460069392364, 4937.975310123426, 4940.382452193476, 4995.675281106716, 4903.5586797188425, 4927.0, 4939.851804445872, 4953.851384458472, 4964.032013757283, 4956.256561515729, 4968.776405061781, 4971.875703107379, 4984.22744474607, 5026.723530205801, 4179.352200408881, 4301.720388174758, 4307.8492252771, 4309.870703878889, 4372.978135109304, 3684.907877303035, 3735.0475628714503, 3786.280606684721, 3814.8474061037805, 3877.6703980161437, 4330.566943305707, 4332.653387728974, 4335.328024156261, 4343.2399330117105, 4393.780310984438, 5060.84817455477, 5084.084864724385, 5085.211792172219, 5085.338905942203, 5146.0479811235045, 4199.097194103282, 4247.49030116388, 4265.616094551505, 4270.210011147948, 4322.135572885435, 4534.251848444969, 4535.591796738309, 4575.359449677047, 4579.816807327737, 4596.080783843245, 4637.489876113625, 4646.349511068385, 4652.6975746577045, 4654.483435631531, 4701.764911754467, 4865.537773911473, 4953.23224900141, 4973.353464049796, 4994.650374473752, 5032.773525191448, 4635.814567417266, 4676.064787042537, 4676.625869930465, 4719.693219940693, 4731.787069581808, 4935.777889995031, 4940.92588611164, 4943.406791184937, 4952.479989601185, 5005.024020316004, 4885.364902562644, 4960.082384758831, 4998.175301075427, 5004.649674522749, 5077.238414237894, 4848.7090774553635, 4860.076585448754, 4864.124457597666, 4914.066327397783, 4926.359573255454, 4861.927071094007, 4872.585830204473, 4875.341828853201, 4876.390451193601, 4922.975385123052, 4637.536246375335, 4763.190257656276, 4833.468318484894, 4869.878253043702, 4894.632902532253, 4992.15133427311, 5011.824586139468, 5020.347354843847, 5040.294358789699, 5074.289599456005, 4885.560299572913, 4900.975495122501, 4907.165781817171, 4907.509249075064, 4964.35463389757], "value": 4588.988187059386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1544687033496, 589.3487696095817, 590.881823635273, 591.3111225422383, 593.1695626123428, 29094.563581546267, 30051.54922676159, 30083.699163008365, 30118.849405752997, 30187.547186792217, 38033.429498557474, 39235.607643923555, 39285.0, 42747.717568472915, 42874.571254287446, 7655.234476552342, 7784.1826608206175, 7789.493682910621, 7793.415493837956, 7796.220377962187, 7040.436765058783, 7714.729984450545, 7787.844243115134, 7798.064232292105, 7803.258690424401, 9913.801723965553, 10186.59253629854, 10194.184465242763, 10516.21128415368, 10526.105281051081, 10049.296549241555, 10111.443870587114, 10126.848097278547, 10129.037741414553, 10133.088022077975, 9664.081912218327, 9711.757206069835, 9726.610935562569, 9731.41611503312, 9737.0, 37226.44160337597, 37262.0, 37377.81311093427, 37490.0, 37501.62498375009, 2796.5385711357603, 2889.508783506809, 2926.2976885547528, 2952.6604440489405, 3074.0, 27734.0, 28013.159605211877, 28315.00897468579, 28389.212099402095, 28470.28824279389, 3435.9484607730906, 3452.361313157074, 3467.427874400721, 3483.930321393583, 3495.94756078659, 250936.0, 253354.0, 253478.0, 254078.0, 254562.0, 52509.2123618146, 52671.73664131655, 52749.472505274454, 52885.7355713219, 52904.0, 31483.370332593677, 32605.18487037843, 32727.67272327294, 34407.65592344045, 34417.65582344194, 14894.925525372304, 14928.253587320807, 14930.925345373204, 14938.0, 15061.849381506045, 11369.829452558219, 11465.197436179387, 11545.0, 11545.134114941413, 11546.480408381643, 11197.216194866443, 11574.189806713617, 11583.76832463346, 17527.123643818013, 17684.911575442296, 5703.828885133453, 6656.0, 6735.124433823669, 6891.0, 6952.2352541220425, 784.5096814490943, 836.481381543447, 854.273867212864, 861.1431625532636, 928.4201946302635, 26872.865635671697, 27341.589876151873, 27347.45305093887, 27803.860980695372, 27835.103085568036, 942.7643089227693, 956.7895063086249, 986.4032260482448, 1002.8545860850281, 1053.957841686324, 13856.722865542633, 14562.635934101732, 14637.121772693672, 14677.706445871236, 14742.875974295224, 374282.0, 378264.17358263955, 378349.0, 378952.0, 379224.0, 40388.79805600953, 45225.321620175724, 47018.0, 47328.290075648896, 47350.0, 1150.4132892225193, 1172.1823306211463, 1176.353005846781, 1176.7646470705893, 1179.4406138679087, 26824.731752683005, 27717.584236236875, 28273.15180544587, 28555.143345699664, 29145.85427072936, 40731.59268407278, 41326.0, 41328.38007429951, 41342.37986430266, 41362.379564307164, 311565.0, 311792.0, 428105.0, 431629.0, 437552.0, 36976.445353319185, 37146.62853371432, 37256.254874902894, 37439.251214976095, 37735.433968489946, 40271.597284026786, 40636.1872762549, 40834.79582602068, 40958.385624215065, 41280.58719412767, 34645.0, 34759.131021723646, 34932.650673493954, 35102.0, 35551.11122221862, 33818.830905845316, 34400.0, 34672.479912801835, 34814.303713926085, 34818.47772283367, 34645.48031779475, 34917.650823491436, 34927.30145397129, 35312.29375412426, 35654.643453565135, 30721.539176911916, 31975.200619983756, 32193.839030804695, 32263.51604725884, 32525.34949301048, 24289.51420971606, 24560.385990350384, 24566.140185093434, 25011.374715631526, 25182.370440739127], "value": 17430.416825873548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4664536741213, 334.65530503581306, 338.839051450561, 341.87524535014876, 356.74492737692543, 12309.199902006374, 15516.456924007647, 16170.676586468264, 16534.255958481866, 17487.91256043718, 16423.671526569462, 16580.751288730648, 16885.409010684627, 17118.914405427957, 17216.913915430407, 4922.729249891255, 4960.7767650455635, 5037.672551284173, 5038.974805125988, 5074.238864170367, 3641.308151451216, 4995.750212489379, 5076.543111119999, 5080.872978175538, 5473.0, 5698.8005419810315, 5793.391693872146, 5803.071508558632, 5805.042168042268, 5807.796727114552, 5177.326947496839, 5396.4333744957, 5456.127019676833, 5788.0, 5794.159846822208, 5359.839204823861, 5389.191621256804, 5399.623096110506, 5400.405955344909, 5401.27082843815, 11990.280583164951, 12164.391780410944, 12254.264744115293, 12396.0, 12513.186642868184, 1827.6710192165406, 1927.5181204698824, 2030.6547886859269, 2059.9485012874648, 2329.429289824004, 8804.47173169612, 9362.765930851716, 9381.530923453869, 10923.508442120125, 13164.736705265937, 1648.6290584618484, 1703.1228917107699, 1704.4886534039863, 1768.8319609637065, 1788.6959216933024, 63767.362326376606, 67440.6627966862, 68283.3171668287, 68333.0, 68411.97382039324, 9862.50687465624, 9862.556184971694, 9980.101790838859, 10208.897911020944, 10293.588256469657, 13791.51729689456, 13814.033017688866, 13826.792598111037, 13836.861631383557, 13880.4447822088, 7016.92983070173, 7312.634368281565, 7329.230430804795, 7532.54804711719, 7594.5063570867715, 6958.165020197507, 7027.824304392431, 7162.3195796400305, 7163.606001669854, 7210.098737657793, 4019.055521952339, 4049.271131196413, 4140.937885931713, 4223.5142958559545, 4378.299472084451, 1753.815849335827, 1801.918913648889, 1802.4772815883248, 1802.9909850450663, 1862.850971922243, 682.5188242289174, 856.1609622569916, 871.7079778274223, 892.6920212526668, 893.3032234856822, 16223.188840557925, 16405.097719625534, 16493.83506164923, 16746.916265418597, 17345.7398139028, 826.2522417212432, 836.9372297077622, 842.9114942931027, 878.83302172587, 898.205088496672, 7998.840313115543, 9658.179054780423, 9871.457069861226, 9895.554700038516, 9997.150242229347, 347621.0, 349546.0, 357628.0, 359070.81858363206, 360827.0, 47686.28470572944, 69432.0, 70335.64832175807, 73049.6347518259, 77454.612726936, 898.7393655839865, 906.4787747045475, 936.541094863512, 938.333783014054, 943.1558754914313, 15542.611434714223, 15611.219439027776, 16247.59381015484, 16267.59331016734, 16521.752173717163, 28612.713872861004, 35964.28071438609, 37501.0, 37732.811335943145, 38135.809320953216, 49624.25563616621, 51835.74082129565, 52093.0, 52703.47296527139, 52961.0, 7091.751788687371, 7467.402607791472, 7602.201768814195, 7786.532808031309, 7995.760127196193, 11441.313521188755, 11659.88340116588, 11875.643730688093, 11892.881071189524, 11962.282263064244, 9668.516574171123, 10191.133753631024, 10331.483425828828, 10546.26176167661, 10621.362718236931, 9908.653197138066, 9923.40459572428, 10520.316179448311, 10679.946600266949, 10689.0, 9951.601935922483, 10151.796964060824, 10221.897781022095, 10350.32722873041, 10406.47967601632, 7129.251428599922, 7695.692172313269, 7753.534787912743, 7853.960730196312, 8155.9592202040985, 8040.597970101355, 9380.249580033444, 10049.397036177852, 10259.589616415558, 10497.265191436527], "value": 8003.917442479065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.438695747786, 1365.385576490579, 1433.792100145479, 1635.1578936847534, 1663.4676903390905, 6639.336066393358, 7284.8178795530075, 7321.707131714738, 7866.92133078669, 7868.645910934015, 7360.558366498014, 7701.807454813633, 7743.380529557636, 7756.883646745303, 7757.10793258774, 2179.324409433073, 2198.3404978506464, 2202.41635966469, 2206.2719302630094, 2216.390492614528, 1827.8537716982676, 2097.979020209794, 2103.1902717453736, 2133.434639820449, 2203.8126759225484, 2116.185268671557, 2147.6134295826746, 2177.096504950444, 2177.2923799765063, 2177.923772667957, 2093.9895300523553, 2098.401955442707, 2114.7885211478883, 2151.9354419367287, 2157.6871353653787, 2069.193014724259, 2083.020980139347, 2087.3842216546004, 2090.2266161520333, 2096.3082182879766, 7708.6916523339, 7747.690092396298, 7770.0, 7776.261255180749, 7781.299683028498, 4272.807723652443, 4391.704447188087, 4440.111977604492, 4450.26570615848, 4453.821847126111, 2765.405437830876, 2937.1629085710683, 2985.701429857019, 2989.058446589339, 2999.5350720638335, 917.7659696777346, 922.9584668689926, 938.4088024544561, 939.6945992552379, 952.7713348796239, 10055.195584353161, 10074.496275186211, 10085.0, 10111.797764044752, 10118.089371956487, 3984.6812255019527, 4065.3495440729935, 4115.382692596135, 4173.874783756492, 4179.247735407595, 8501.65993360271, 8551.486910785372, 8561.357898157663, 8566.229039386486, 8571.95714021426, 4389.714668546534, 4392.055708022726, 4392.692511524227, 4394.143142087326, 4397.758123303185, 3941.3496773032703, 4023.094803669151, 4037.1118353962083, 4046.676265898721, 4051.47330846988, 3527.1358517163458, 3579.713622910161, 3650.908727281839, 3656.11709969366, 3661.139632186434, 1078.9028987391173, 1129.6328693174587, 1156.1386766858575, 1165.1028707894873, 1180.4628893853276, 630.5775130662468, 639.9584027038228, 645.0099097884818, 719.0759873562447, 750.0287128169034, 4978.303037574742, 5057.974710126426, 5085.415177254663, 5172.637915345889, 5243.973780131075, 800.5396896784256, 832.1470492744985, 835.2900034970348, 840.3907167303778, 901.0538934119148, 3372.426687463088, 3402.5236466894653, 3458.5330980317335, 3508.4737289406285, 3508.6666766657127, 9203.217726493189, 9586.0, 9614.134727874525, 9621.951890240503, 9625.51872406377, 9560.56977436017, 9579.323618366758, 9580.904190958141, 9592.472414017157, 9593.28050396223, 7094.858102837914, 7251.0, 7348.96325518369, 7352.448566357544, 7364.374028207555, 5111.156659151198, 5177.352830896138, 5188.870278243074, 5193.454687257784, 5298.6820790751135, 8349.749507514784, 8392.4544904581, 8395.790105247417, 8421.536815474963, 8460.661573536989, 7900.091489478784, 8254.215849494289, 8255.174482551936, 8533.957330213558, 8634.179752923463, 6205.937940620536, 6375.171227740364, 6376.872462550816, 6379.553431259767, 6381.3937675920715, 7041.788746337618, 7091.432685385053, 7122.60825654594, 7134.464915131282, 7144.535605185646, 5415.296011518478, 6174.938250617436, 6311.211098612674, 6343.492520598434, 6524.217093948567, 6150.04674275488, 6254.562180647311, 6265.0, 6386.808395748135, 6549.4760419167305, 6076.726547305293, 6082.300535438481, 6130.969345153424, 6131.233595800525, 6136.570440069152, 4264.530901600883, 4356.869293921188, 4455.108978204307, 4470.463544374566, 4569.771511424482, 4503.684742068155, 4532.342810292555, 4587.793549290357, 4607.193741095362, 4638.814447422065], "value": 3999.1393725700696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.10730041624083, 297.40370557033145, 303.1360622226654, 303.9057892053462, 306.7591940326844, 4845.6850304730215, 4864.513548645143, 4864.659473836833, 4890.168671325879, 4896.898197905474, 4721.3390125382475, 4753.429588449391, 4835.564799168074, 4838.443578988417, 4842.128416884968, 3563.6258192889695, 3638.599754027055, 3780.2232950513217, 3786.2048969716393, 3823.541175058997, 3763.41667041609, 3768.566614839301, 3780.527434070741, 3781.3382658034734, 3797.582265950757, 3711.8100320810718, 3722.516072910518, 3735.32923959369, 3737.8317975691025, 3755.6432138946757, 3554.3246783111254, 3598.5681718193855, 3740.1584643455276, 3752.43713442983, 3766.886993390203, 3323.351946370459, 3337.6996070353784, 3349.3038104326006, 3351.463765797461, 3362.277110421271, 4664.696794708333, 4678.6491013174145, 4685.758274057377, 4687.273472611751, 4720.362751028601, 4181.728187667792, 4297.591728785792, 4305.268104422255, 4309.482862056542, 4310.288802347609, 4970.602351811846, 4992.929348450713, 4997.250412438163, 5000.199968005102, 5014.949850501484, 3666.9083272918124, 3677.687396571295, 3681.4661874028116, 3689.631036896316, 3695.113172838526, 5124.795008199668, 5217.399999000126, 5222.973885130588, 5230.97384513075, 5258.7370631468275, 3734.458503516975, 3756.887293381203, 3758.3986562149926, 3768.4535742317757, 3769.9057523561582, 3784.7350685452307, 3788.0, 3808.124131449782, 3812.409076593077, 3836.290286297044, 4321.783910804447, 4326.891827704332, 4342.544032876565, 4342.956570434319, 4348.499922508952, 4891.1685013547785, 4993.975030124826, 5000.524950129732, 5047.217681259411, 5106.514881086291, 1299.740051989606, 1314.7633425983224, 1317.960461186166, 1318.3276528970102, 1319.808627748971, 816.6814942172557, 842.0274582856811, 846.9364797640202, 856.4005196362571, 856.5717141429285, 4210.473690788652, 4316.503602085738, 4370.497392799805, 4427.247367947457, 4451.732896026248, 5166.844994650167, 5168.9224661630105, 5172.27588137661, 5177.430482646906, 5179.792808287626, 4409.8456554021095, 4412.955870441255, 4434.162136232813, 4448.221561226837, 4448.243798554254, 2596.4287856671504, 2725.087095822882, 2726.82275652082, 2751.380939288644, 2763.3782398960075, 4797.856064318076, 4807.158747219222, 4808.543188397097, 4816.397950256218, 4826.831060912851, 5134.12719837621, 5279.709615971158, 5291.788328466818, 5302.09864323066, 5313.814016509404, 4776.928346074812, 4812.855614331575, 4837.3311207634015, 4842.5157484251995, 4857.757112144308, 5142.562882155059, 5153.201253805666, 5173.560247379015, 5215.55667768244, 5227.686338819683, 4846.95153048465, 5088.974555127201, 5093.159628661229, 5093.668911520739, 5113.156329205788, 4828.275758636232, 4843.2250839865455, 4854.05345957549, 4863.659543831898, 4866.586340160984, 3625.746197766131, 3630.491731157693, 3636.30910127075, 3669.101070237809, 3676.963230367769, 5148.845534633967, 5258.553022992935, 5261.36863576358, 5263.315768950165, 5265.341832270966, 5039.0, 5084.161113416245, 5108.284840122312, 5112.309838171799, 5120.3343565337755, 5096.592272618256, 5097.796088156432, 5103.209002604603, 5106.591472682251, 5113.948860511347, 4872.9512704872495, 4911.935236845081, 4968.0, 4977.104121258209, 5017.222330538772, 4861.538153875376, 4939.950600493949, 5061.544460998528, 5077.365329333833, 5089.898202036013, 4955.876103097307, 4960.156773348467, 4960.553550180501, 4962.6774259673, 4963.081829861487], "value": 3804.170734754245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8405438504413, 593.4037439288314, 595.988080238395, 605.5367643752529, 671.2012704881191, 11547.13396495262, 11934.82097768532, 12498.937505312471, 12524.123311368185, 12548.874511254884, 12560.685982850433, 12606.0, 12672.366381680926, 12685.936570317159, 12692.238465692042, 590.790269454344, 736.834212302233, 753.7248904149973, 754.7924320811766, 755.1655420760063, 740.5482655580092, 763.8472305538887, 765.6784150656738, 768.69636493585, 771.5910567399259, 797.6251161953872, 798.5807451088167, 799.7480793550042, 799.9640016199285, 800.2837460472873, 633.3856159525253, 799.3365506629484, 799.4803377804416, 799.5122974985254, 799.6801279488193, 558.1265319774581, 574.4026212738746, 576.3458474631282, 576.4350936082662, 576.7606443326015, 11210.103191744642, 11222.49498772549, 11236.943815280953, 11253.212275140744, 11258.54965801367, 11965.820512692317, 12199.268043917305, 12217.572384966483, 12683.302418366986, 13416.060875738702, 11819.231749936227, 12247.326397048158, 12341.0, 12519.56181533642, 13023.348832558335, 4129.938050929209, 4134.287221022668, 4164.9583504164875, 4287.249731297011, 4339.522652508222, 65992.34007659958, 67224.66387668079, 67905.0, 68732.65633671799, 68750.31249687489, 10082.143017843566, 10330.431826249629, 10457.790844183073, 10481.947590262153, 10588.205884558689, 18272.908635456737, 18533.166007529693, 18560.443186704422, 18570.535736606424, 18600.34898778536, 6357.347089756697, 6394.808155755335, 6433.0, 6533.314002029719, 6746.392824645805, 3650.233450975325, 3710.8515659373325, 3756.2111956489443, 3758.642928921748, 3819.1406933440308, 2653.6284920111198, 2730.1127133681234, 2738.274357295318, 2739.6849362323187, 2740.849253291048, 467.25706127257826, 471.41309070207126, 472.832144588673, 478.75344197738195, 479.74093989245415, 429.7894031924397, 434.7521912509839, 459.50431345968656, 480.8605504403684, 491.2067011775956, 7240.239774823568, 7559.773206803805, 7678.155402905676, 7849.0, 7908.406869484812, 475.2324995132836, 493.36848833493184, 509.5745052880812, 515.1757188498448, 528.7567718849373, 3368.6799754023327, 3425.847130778342, 3474.513568100468, 3514.7012503937453, 3624.0939765058733, 71256.64371678213, 105034.0, 105702.47148764208, 106402.0, 111596.0, 93779.0, 93918.0, 94011.0, 95264.0, 95811.52094239484, 79699.60150199212, 81127.0, 81552.59223703844, 82342.58828705818, 82893.0, 6812.795616131524, 7142.821429464305, 7173.713051477883, 7194.100737407824, 7243.782686519413, 31382.215444614067, 38630.6136938627, 39404.80297598494, 39496.42014319395, 42195.7890210547, 43030.13939721251, 47866.042679145525, 60903.69548152231, 62249.68875155595, 62427.375726243976, 11007.119430445706, 11014.559417623206, 11173.497192626513, 11251.831222531504, 11501.597444089752, 12732.618021459371, 12961.870381296067, 13324.333783310989, 13407.128536645087, 13633.863661363259, 12299.815502767287, 12377.938110309391, 12550.49798008106, 13029.241281691964, 13390.26353550564, 12355.62933112008, 12358.62924112242, 12793.552225672056, 13415.932920335335, 13644.863551364757, 11161.0, 11865.288082715064, 11991.160618756603, 12202.572909948109, 12558.120931534704, 9311.487868167045, 9694.36986595869, 9717.222622190066, 9753.658621948198, 9824.361416507903, 10095.495225238561, 10467.319624224401, 10507.94746026265, 10586.153107751208, 10600.522976465923], "value": 6414.69443986727, "unit": "score"}], "name": "dromaeo_css", "value": 6299.364503243778, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 131.0, 116.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 153.0, 186.0, 125.0, 154.0, 145.0, 132.0, 175.0, 128.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 164.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 164.0, 76.0, 78.0, 77.0, 76.0, 166.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 146.0, 83.0, 84.0, 83.0, 145.0, 84.0, 83.0, 131.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 146.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 82.0, 83.0, 84.0, 83.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 142.0, 134.0, 134.0, 148.0, 136.0, 138.0, 179.0, 137.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 177.0, 173.0, 170.0, 170.0, 171.0, 174.0, 169.0, 169.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 69.0, 71.0, 69.0, 67.0, 67.0, 66.0, 66.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1575.8000000000002, "alertThreshold": 2.0}]} 06:39:38 INFO - Return code: 0 06:39:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:39:38 INFO - # TBPL SUCCESS # 06:39:38 INFO - Running post-action listener: _resource_record_post_action 06:39:38 INFO - [mozharness: 2016-09-01 13:39:38.415095Z] Finished run-tests step (success) 06:39:38 INFO - Running post-run listener: _resource_record_post_run 06:39:38 INFO - Total resource usage - Wall time: 1212s; CPU: 13.0%; Read bytes: 7946240; Write bytes: 420057088; Read time: 2420; Write time: 797164 06:39:38 INFO - TinderboxPrint: CPU usage
13.1% 06:39:38 INFO - TinderboxPrint: I/O read bytes / time
7,946,240 / 2,420 06:39:38 INFO - TinderboxPrint: I/O write bytes / time
420,057,088 / 797,164 06:39:38 INFO - TinderboxPrint: CPU idle
8,406.3 (86.9%) 06:39:38 INFO - TinderboxPrint: CPU user
1,202.3 (12.4%) 06:39:38 INFO - TinderboxPrint: Swap in / out
0 / 0 06:39:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4636672; Read time: 0; Write time: 316 06:39:38 INFO - run-tests - Wall time: 1197s; CPU: 13.0%; Read bytes: 5709824; Write bytes: 415420416; Read time: 2184; Write time: 796848 06:39:39 INFO - Running post-run listener: _upload_blobber_files 06:39:39 INFO - Blob upload gear active. 06:39:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:39:39 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 06:39:39 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:39:39 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:39:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:40 INFO - (blobuploader) - INFO - Done attempting. 06:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:40 INFO - (blobuploader) - INFO - Done attempting. 06:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:44 INFO - (blobuploader) - INFO - Done attempting. 06:39:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:39:44 INFO - Return code: 0 06:39:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:39:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:39:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad39ae1927e20db37fb3c29ec56865ff8cd6bf034a70f42218c39bf91916e5f5d14d68fa072d2f0d03fd0b2f097129bcb34e223572570a5424894663073f3d17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16465d41acf352553a549d7b9af5f94aefbd05df6f50203a39302034f4f510add84df20b8c91a82a11a53d42cde831ffc06d91381f402d457ae8307042fa2eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/975cfcc0d2c44ab71f1b1e7bf08d4145b59d0a58534d049e042cb85f70cb4f287548d97082bf4caa797cf36bed561914bc27555af7e46c316529d0994106aaff"} 06:39:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:39:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:39:44 INFO - Contents: 06:39:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad39ae1927e20db37fb3c29ec56865ff8cd6bf034a70f42218c39bf91916e5f5d14d68fa072d2f0d03fd0b2f097129bcb34e223572570a5424894663073f3d17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16465d41acf352553a549d7b9af5f94aefbd05df6f50203a39302034f4f510add84df20b8c91a82a11a53d42cde831ffc06d91381f402d457ae8307042fa2eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/975cfcc0d2c44ab71f1b1e7bf08d4145b59d0a58534d049e042cb85f70cb4f287548d97082bf4caa797cf36bed561914bc27555af7e46c316529d0994106aaff"} 06:39:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:39:44 INFO - Copying logs to upload dir... 06:39:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:39:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.552609 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-09-01 06:39:44.935024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:39:44.938631) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 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-Non-PGO/sha512/ad39ae1927e20db37fb3c29ec56865ff8cd6bf034a70f42218c39bf91916e5f5d14d68fa072d2f0d03fd0b2f097129bcb34e223572570a5424894663073f3d17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16465d41acf352553a549d7b9af5f94aefbd05df6f50203a39302034f4f510add84df20b8c91a82a11a53d42cde831ffc06d91381f402d457ae8307042fa2eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/975cfcc0d2c44ab71f1b1e7bf08d4145b59d0a58534d049e042cb85f70cb4f287548d97082bf4caa797cf36bed561914bc27555af7e46c316529d0994106aaff"} build_url:https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/WlbXvTxARwuyxGOKd_DrGg/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-Non-PGO/sha512/ad39ae1927e20db37fb3c29ec56865ff8cd6bf034a70f42218c39bf91916e5f5d14d68fa072d2f0d03fd0b2f097129bcb34e223572570a5424894663073f3d17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16465d41acf352553a549d7b9af5f94aefbd05df6f50203a39302034f4f510add84df20b8c91a82a11a53d42cde831ffc06d91381f402d457ae8307042fa2eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/975cfcc0d2c44ab71f1b1e7bf08d4145b59d0a58534d049e042cb85f70cb4f287548d97082bf4caa797cf36bed561914bc27555af7e46c316529d0994106aaff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:39:44.964333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:39:44.964664) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472735467.350175-384489057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004341 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:39:45.048015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:39:45.048354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:39:45.048699) ========= ========= Total master_lag: 0.39 =========