builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1471109008.05 results: success (0) buildid: 20160813102327 builduid: de354ae7e25f43cb90ec266c24619a1d revision: f50b8c335e195a6c54f144a678fd0b7913d8dd8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.053119) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.053572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.053883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.069876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.070241) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-13 10:23:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-08-13 10:23:29 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.199935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.200228) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.249352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:28.249716) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f50b8c335e195a6c54f144a678fd0b7913d8dd8a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f50b8c335e195a6c54f144a678fd0b7913d8dd8a --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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-13 10:23:29,557 truncating revision to first 12 chars 2016-08-13 10:23:29,557 Setting DEBUG logging. 2016-08-13 10:23:29,558 attempt 1/10 2016-08-13 10:23:29,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f50b8c335e19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 10:23:30,018 unpacking tar archive at: mozilla-inbound-f50b8c335e19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.819553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:29.083348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:29.083668) ========= script_repo_revision: f50b8c335e195a6c54f144a678fd0b7913d8dd8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:29.084104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:29.084387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 10:23:29.093421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-13 10:23:29.093711) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:23:30 INFO - MultiFileLogger online at 20160813 10:23:30 in /builds/slave/test 10:23:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:23:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:23:30 INFO - {'append_to_log': False, 10:23:30 INFO - 'base_work_dir': '/builds/slave/test', 10:23:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:23:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:23:30 INFO - 'branch': 'Mozilla-Inbound', 10:23:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:30 INFO - 'config_files': ('talos/linux_config.py',), 10:23:30 INFO - 'default_actions': ('clobber', 10:23:30 INFO - 'read-buildbot-config', 10:23:30 INFO - 'download-and-extract', 10:23:30 INFO - 'populate-webroot', 10:23:30 INFO - 'create-virtualenv', 10:23:30 INFO - 'install', 10:23:30 INFO - 'run-tests'), 10:23:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:30 INFO - 'download_minidump_stackwalk': True, 10:23:30 INFO - 'download_symbols': 'ondemand', 10:23:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:23:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:23:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:23:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:23:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:30 INFO - 'installer_path': 'installer.exe', 10:23:30 INFO - 'log_level': 'info', 10:23:30 INFO - 'log_name': 'talos', 10:23:30 INFO - 'log_to_console': True, 10:23:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:23:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:23:30 INFO - 'opt_config_files': (), 10:23:30 INFO - 'pip_index': False, 10:23:30 INFO - 'sps_profile': False, 10:23:30 INFO - 'sps_profile_interval': 0, 10:23:30 INFO - 'suite': 'dromaeojs', 10:23:30 INFO - 'system_bits': '32', 10:23:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:30 INFO - 'title': 'talos-linux64-ix-057', 10:23:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:23:30 INFO - 'use_talos_json': True, 10:23:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:23:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:30 INFO - 'work_dir': 'build'} 10:23:30 INFO - [mozharness: 2016-08-13 17:23:30.492159Z] Running clobber step. 10:23:30 INFO - Running pre-action listener: _resource_record_pre_action 10:23:30 INFO - Running main action method: clobber 10:23:30 INFO - rmtree: /builds/slave/test/build 10:23:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:23:31 INFO - Running post-action listener: _resource_record_post_action 10:23:31 INFO - [mozharness: 2016-08-13 17:23:31.463684Z] Finished clobber step (success) 10:23:31 INFO - [mozharness: 2016-08-13 17:23:31.463784Z] Running read-buildbot-config step. 10:23:31 INFO - Running pre-action listener: _resource_record_pre_action 10:23:31 INFO - Running main action method: read_buildbot_config 10:23:31 INFO - Using buildbot properties: 10:23:31 INFO - { 10:23:31 INFO - "project": "", 10:23:31 INFO - "product": "firefox", 10:23:31 INFO - "script_repo_revision": "production", 10:23:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:23:31 INFO - "repository": "", 10:23:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:23:31 INFO - "buildid": "20160813102327", 10:23:31 INFO - "stage_platform": "linux64-pgo", 10:23:31 INFO - "basedir": "/builds/slave/test", 10:23:31 INFO - "buildnumber": 2237, 10:23:31 INFO - "platform": "ubuntu64_hw", 10:23:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:23:31 INFO - "slavebuilddir": "test", 10:23:31 INFO - "branch": "mozilla-inbound", 10:23:31 INFO - "revision": "f50b8c335e195a6c54f144a678fd0b7913d8dd8a", 10:23:31 INFO - "slavename": "talos-linux64-ix-057", 10:23:31 INFO - "builduid": "de354ae7e25f43cb90ec266c24619a1d", 10:23:31 INFO - "repo_path": "integration/mozilla-inbound" 10:23:31 INFO - } 10:23:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:23:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 10:23:31 INFO - Running post-action listener: _resource_record_post_action 10:23:31 INFO - [mozharness: 2016-08-13 17:23:31.466125Z] Finished read-buildbot-config step (success) 10:23:31 INFO - [mozharness: 2016-08-13 17:23:31.466213Z] Running download-and-extract step. 10:23:31 INFO - Running pre-action listener: _resource_record_pre_action 10:23:31 INFO - Running main action method: download_and_extract 10:23:31 INFO - mkdir: /builds/slave/test/build/tests 10:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:23:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:31 INFO - Downloaded 1361 bytes. 10:23:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:23:31 INFO - Using the following test package requirements: 10:23:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:23:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:23:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:23:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'jsshell-linux-x86_64.zip'], 10:23:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:23:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:23:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:23:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:23:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:23:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:23:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:23:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:23:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:31 INFO - Downloaded 21836446 bytes. 10:23:31 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 10:23:36 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 10:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:23:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:36 INFO - Downloaded 21836446 bytes. 10:23:36 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 10:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:23:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:43 INFO - Downloaded 14413719 bytes. 10:23:43 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 10:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:44 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:23:44 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/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 10:23:49 INFO - Downloaded 59388237 bytes. 10:23:49 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:23:49 INFO - mkdir: /builds/slave/test/properties 10:23:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:23:49 INFO - Writing to file /builds/slave/test/properties/build_url 10:23:49 INFO - Contents: 10:23:49 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:23:49 INFO - Running post-action listener: _resource_record_post_action 10:23:49 INFO - Running post-action listener: set_extra_try_arguments 10:23:49 INFO - [mozharness: 2016-08-13 17:23:49.529229Z] Finished download-and-extract step (success) 10:23:49 INFO - [mozharness: 2016-08-13 17:23:49.529454Z] Running populate-webroot step. 10:23:49 INFO - Running pre-action listener: _resource_record_pre_action 10:23:49 INFO - Running main action method: populate_webroot 10:23:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:23:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:23:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:23:49 INFO - '--tppagecycles', 10:23:49 INFO - '7'], 10:23:49 INFO - 'tests': ['tsvgm']}}, 10:23:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:23:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:23:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:23:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:23:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['damp', 'tps']}, 10:23:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'tests': ['damp', 'tps']}, 10:23:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['dromaeo_dom']}, 10:23:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:23:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['basic_compositor_video']}, 10:23:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:23:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['a11yr', 10:23:49 INFO - 'ts_paint', 10:23:49 INFO - 'tpaint', 10:23:49 INFO - 'sessionrestore', 10:23:49 INFO - 'sessionrestore_no_auto_restore', 10:23:49 INFO - 'tabpaint']}, 10:23:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['tsvgx', 10:23:49 INFO - 'tsvgr_opacity', 10:23:49 INFO - 'tart', 10:23:49 INFO - 'tscrollx', 10:23:49 INFO - 'cart']}, 10:23:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:23:49 INFO - 'tsvgr_opacity', 10:23:49 INFO - 'tart', 10:23:49 INFO - 'tscrollx', 10:23:49 INFO - 'cart']}, 10:23:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'talos_options': ['--disable-e10s'], 10:23:49 INFO - 'tests': ['tp5o']}, 10:23:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'tests': ['tp5o']}, 10:23:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'talos_options': ['--disable-e10s', 10:23:49 INFO - '--xperf_path', 10:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:49 INFO - 'tests': ['tp5n']}, 10:23:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:49 INFO - 'talos_options': ['--xperf_path', 10:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:49 INFO - 'tests': ['tp5n']}}, 10:23:49 INFO - 'talos.zip': {'path': '', 10:23:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:23:49 INFO - Running post-action listener: _resource_record_post_action 10:23:49 INFO - [mozharness: 2016-08-13 17:23:49.544593Z] Finished populate-webroot step (success) 10:23:49 INFO - [mozharness: 2016-08-13 17:23:49.544681Z] Running create-virtualenv step. 10:23:49 INFO - Running pre-action listener: _resource_record_pre_action 10:23:49 INFO - Running main action method: create_virtualenv 10:23:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:23:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:23:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:23:49 INFO - Using real prefix '/usr' 10:23:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:23:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:23:52 INFO - Installing pip.................done. 10:23:52 INFO - Return code: 0 10:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:23:52 INFO - Using env: {'DISPLAY': ':0', 10:23:52 INFO - 'HOME': '/home/cltbld', 10:23:52 INFO - 'LANG': 'en_US.UTF-8', 10:23:52 INFO - 'LANGUAGE': 'en_US:en', 10:23:52 INFO - 'LOGNAME': 'cltbld', 10:23:52 INFO - 'MAIL': '/var/mail/cltbld', 10:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:52 INFO - 'MOZ_NO_REMOTE': '1', 10:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:52 INFO - 'NO_EM_RESTART': '1', 10:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:52 INFO - 'PWD': '/builds/slave/test', 10:23:52 INFO - 'SHELL': '/bin/bash', 10:23:52 INFO - 'SHLVL': '1', 10:23:52 INFO - 'TERM': 'linux', 10:23:52 INFO - 'TMOUT': '86400', 10:23:52 INFO - 'USER': 'cltbld', 10:23:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:52 INFO - '_': '/tools/buildbot/bin/python'} 10:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:23:52 INFO - Cleaning up... 10:23:52 INFO - Return code: 0 10:23:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:23:52 INFO - Using env: {'DISPLAY': ':0', 10:23:52 INFO - 'HOME': '/home/cltbld', 10:23:52 INFO - 'LANG': 'en_US.UTF-8', 10:23:52 INFO - 'LANGUAGE': 'en_US:en', 10:23:52 INFO - 'LOGNAME': 'cltbld', 10:23:52 INFO - 'MAIL': '/var/mail/cltbld', 10:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:52 INFO - 'MOZ_NO_REMOTE': '1', 10:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:52 INFO - 'NO_EM_RESTART': '1', 10:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:52 INFO - 'PWD': '/builds/slave/test', 10:23:52 INFO - 'SHELL': '/bin/bash', 10:23:52 INFO - 'SHLVL': '1', 10:23:52 INFO - 'TERM': 'linux', 10:23:52 INFO - 'TMOUT': '86400', 10:23:52 INFO - 'USER': 'cltbld', 10:23:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:52 INFO - '_': '/tools/buildbot/bin/python'} 10:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:52 INFO - Downloading/unpacking psutil>=3.1.1 10:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:54 INFO - Installing collected packages: psutil 10:23:54 INFO - Running setup.py install for psutil 10:23:54 INFO - building 'psutil._psutil_linux' extension 10:23:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:23:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:23:54 INFO - building 'psutil._psutil_posix' extension 10:23:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:23:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:55 INFO - Successfully installed psutil 10:23:55 INFO - Cleaning up... 10:23:55 INFO - Return code: 0 10:23:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:23:55 INFO - Using env: {'DISPLAY': ':0', 10:23:55 INFO - 'HOME': '/home/cltbld', 10:23:55 INFO - 'LANG': 'en_US.UTF-8', 10:23:55 INFO - 'LANGUAGE': 'en_US:en', 10:23:55 INFO - 'LOGNAME': 'cltbld', 10:23:55 INFO - 'MAIL': '/var/mail/cltbld', 10:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:55 INFO - 'MOZ_NO_REMOTE': '1', 10:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:55 INFO - 'NO_EM_RESTART': '1', 10:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:55 INFO - 'PWD': '/builds/slave/test', 10:23:55 INFO - 'SHELL': '/bin/bash', 10:23:55 INFO - 'SHLVL': '1', 10:23:55 INFO - 'TERM': 'linux', 10:23:55 INFO - 'TMOUT': '86400', 10:23:55 INFO - 'USER': 'cltbld', 10:23:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:55 INFO - '_': '/tools/buildbot/bin/python'} 10:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:23:57 INFO - Installing collected packages: mozsystemmonitor 10:23:57 INFO - Running setup.py install for mozsystemmonitor 10:23:57 INFO - Successfully installed mozsystemmonitor 10:23:57 INFO - Cleaning up... 10:23:57 INFO - Return code: 0 10:23:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:23:57 INFO - Using env: {'DISPLAY': ':0', 10:23:57 INFO - 'HOME': '/home/cltbld', 10:23:57 INFO - 'LANG': 'en_US.UTF-8', 10:23:57 INFO - 'LANGUAGE': 'en_US:en', 10:23:57 INFO - 'LOGNAME': 'cltbld', 10:23:57 INFO - 'MAIL': '/var/mail/cltbld', 10:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:57 INFO - 'MOZ_NO_REMOTE': '1', 10:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:57 INFO - 'NO_EM_RESTART': '1', 10:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:57 INFO - 'PWD': '/builds/slave/test', 10:23:57 INFO - 'SHELL': '/bin/bash', 10:23:57 INFO - 'SHLVL': '1', 10:23:57 INFO - 'TERM': 'linux', 10:23:57 INFO - 'TMOUT': '86400', 10:23:57 INFO - 'USER': 'cltbld', 10:23:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:57 INFO - '_': '/tools/buildbot/bin/python'} 10:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:57 INFO - Downloading/unpacking jsonschema==2.5.1 10:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:23:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:23:59 INFO - warning: no files found matching '*.txt' 10:23:59 INFO - no previously-included directories found matching 'build' 10:23:59 INFO - no previously-included directories found matching 'dist' 10:23:59 INFO - no previously-included directories found matching '.git*' 10:23:59 INFO - Installing collected packages: jsonschema, functools32 10:23:59 INFO - Running setup.py install for functools32 10:23:59 INFO - warning: no files found matching '*.txt' 10:23:59 INFO - no previously-included directories found matching 'build' 10:23:59 INFO - no previously-included directories found matching 'dist' 10:23:59 INFO - no previously-included directories found matching '.git*' 10:23:59 INFO - Successfully installed jsonschema functools32 10:23:59 INFO - Cleaning up... 10:23:59 INFO - Return code: 0 10:23:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:59 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:23:59 INFO - Using env: {'DISPLAY': ':0', 10:23:59 INFO - 'HOME': '/home/cltbld', 10:23:59 INFO - 'LANG': 'en_US.UTF-8', 10:23:59 INFO - 'LANGUAGE': 'en_US:en', 10:23:59 INFO - 'LOGNAME': 'cltbld', 10:23:59 INFO - 'MAIL': '/var/mail/cltbld', 10:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:59 INFO - 'MOZ_NO_REMOTE': '1', 10:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:59 INFO - 'NO_EM_RESTART': '1', 10:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:59 INFO - 'PWD': '/builds/slave/test', 10:23:59 INFO - 'SHELL': '/bin/bash', 10:23:59 INFO - 'SHLVL': '1', 10:23:59 INFO - 'TERM': 'linux', 10:23:59 INFO - 'TMOUT': '86400', 10:23:59 INFO - 'USER': 'cltbld', 10:23:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:59 INFO - '_': '/tools/buildbot/bin/python'} 10:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:24:00 INFO - Cleaning up... 10:24:00 INFO - Return code: 0 10:24:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:00 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:24:00 INFO - Using env: {'DISPLAY': ':0', 10:24:00 INFO - 'HOME': '/home/cltbld', 10:24:00 INFO - 'LANG': 'en_US.UTF-8', 10:24:00 INFO - 'LANGUAGE': 'en_US:en', 10:24:00 INFO - 'LOGNAME': 'cltbld', 10:24:00 INFO - 'MAIL': '/var/mail/cltbld', 10:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:00 INFO - 'MOZ_NO_REMOTE': '1', 10:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:00 INFO - 'NO_EM_RESTART': '1', 10:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:00 INFO - 'PWD': '/builds/slave/test', 10:24:00 INFO - 'SHELL': '/bin/bash', 10:24:00 INFO - 'SHLVL': '1', 10:24:00 INFO - 'TERM': 'linux', 10:24:00 INFO - 'TMOUT': '86400', 10:24:00 INFO - 'USER': 'cltbld', 10:24:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:00 INFO - '_': '/tools/buildbot/bin/python'} 10:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:24:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:24:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:02 INFO - Downloading docopt-0.6.1.tar.gz 10:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:24:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:24:02 INFO - Running setup.py install for blobuploader 10:24:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:24:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:24:03 INFO - Running setup.py install for requests 10:24:03 INFO - Running setup.py install for docopt 10:24:03 INFO - Successfully installed blobuploader requests docopt 10:24:03 INFO - Cleaning up... 10:24:03 INFO - Return code: 0 10:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:03 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:03 INFO - Using env: {'DISPLAY': ':0', 10:24:03 INFO - 'HOME': '/home/cltbld', 10:24:03 INFO - 'LANG': 'en_US.UTF-8', 10:24:03 INFO - 'LANGUAGE': 'en_US:en', 10:24:03 INFO - 'LOGNAME': 'cltbld', 10:24:03 INFO - 'MAIL': '/var/mail/cltbld', 10:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:03 INFO - 'MOZ_NO_REMOTE': '1', 10:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:03 INFO - 'NO_EM_RESTART': '1', 10:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:03 INFO - 'PWD': '/builds/slave/test', 10:24:03 INFO - 'SHELL': '/bin/bash', 10:24:03 INFO - 'SHLVL': '1', 10:24:03 INFO - 'TERM': 'linux', 10:24:03 INFO - 'TMOUT': '86400', 10:24:03 INFO - 'USER': 'cltbld', 10:24:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:03 INFO - '_': '/tools/buildbot/bin/python'} 10:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:03 INFO - Running setup.py (path:/tmp/pip-PSk56X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:03 INFO - Running setup.py (path:/tmp/pip-ROTlT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:03 INFO - Running setup.py (path:/tmp/pip-UR9gJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:04 INFO - Running setup.py (path:/tmp/pip-OtlWdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:04 INFO - Running setup.py (path:/tmp/pip-brBDwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:04 INFO - Running setup.py (path:/tmp/pip-miqBkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:04 INFO - Running setup.py (path:/tmp/pip-3E91If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:04 INFO - Running setup.py (path:/tmp/pip-NBImKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:04 INFO - Running setup.py (path:/tmp/pip-0u45ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:04 INFO - Running setup.py (path:/tmp/pip-VTjMBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:04 INFO - Running setup.py (path:/tmp/pip-3IVwRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:04 INFO - Running setup.py (path:/tmp/pip-yKWeM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:04 INFO - Running setup.py (path:/tmp/pip-PFj7_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:04 INFO - Running setup.py (path:/tmp/pip-hJpKoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:04 INFO - Running setup.py (path:/tmp/pip-ZSJl3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:24:04 INFO - Running setup.py (path:/tmp/pip-B0MHEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:24:04 INFO - Running setup.py (path:/tmp/pip-6sKfa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:24:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:24:05 INFO - Running setup.py install for manifestparser 10:24:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Running setup.py install for mozcrash 10:24:05 INFO - Running setup.py install for mozdebug 10:24:05 INFO - Running setup.py install for mozdevice 10:24:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Running setup.py install for mozfile 10:24:05 INFO - Running setup.py install for mozhttpd 10:24:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Running setup.py install for mozinfo 10:24:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Running setup.py install for mozInstall 10:24:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:24:05 INFO - Running setup.py install for mozleak 10:24:05 INFO - Running setup.py install for mozlog 10:24:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Running setup.py install for moznetwork 10:24:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Running setup.py install for mozprocess 10:24:06 INFO - Running setup.py install for mozprofile 10:24:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Running setup.py install for mozrunner 10:24:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Running setup.py install for mozscreenshot 10:24:06 INFO - Running setup.py install for moztest 10:24:06 INFO - Running setup.py install for mozversion 10:24:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:24:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:24:06 INFO - Cleaning up... 10:24:06 INFO - Return code: 0 10:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:06 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:06 INFO - Using env: {'DISPLAY': ':0', 10:24:06 INFO - 'HOME': '/home/cltbld', 10:24:06 INFO - 'LANG': 'en_US.UTF-8', 10:24:06 INFO - 'LANGUAGE': 'en_US:en', 10:24:06 INFO - 'LOGNAME': 'cltbld', 10:24:06 INFO - 'MAIL': '/var/mail/cltbld', 10:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:06 INFO - 'MOZ_NO_REMOTE': '1', 10:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:06 INFO - 'NO_EM_RESTART': '1', 10:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:06 INFO - 'PWD': '/builds/slave/test', 10:24:06 INFO - 'SHELL': '/bin/bash', 10:24:06 INFO - 'SHLVL': '1', 10:24:06 INFO - 'TERM': 'linux', 10:24:06 INFO - 'TMOUT': '86400', 10:24:06 INFO - 'USER': 'cltbld', 10:24:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:06 INFO - '_': '/tools/buildbot/bin/python'} 10:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:07 INFO - Running setup.py (path:/tmp/pip-N0iTKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:07 INFO - Running setup.py (path:/tmp/pip-KskTpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:07 INFO - Running setup.py (path:/tmp/pip-XFJjBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:07 INFO - Running setup.py (path:/tmp/pip-4eeD37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:07 INFO - Running setup.py (path:/tmp/pip-kvIVxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:07 INFO - Running setup.py (path:/tmp/pip-7wwwgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:07 INFO - Running setup.py (path:/tmp/pip-DYXGog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:07 INFO - Running setup.py (path:/tmp/pip-mfuKn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:07 INFO - Running setup.py (path:/tmp/pip-Cwb9fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:07 INFO - Running setup.py (path:/tmp/pip-Wj8UjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:07 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)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:07 INFO - Running setup.py (path:/tmp/pip-vIaX_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:07 INFO - Running setup.py (path:/tmp/pip-Zsk2sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:07 INFO - Running setup.py (path:/tmp/pip-pma7FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:07 INFO - Running setup.py (path:/tmp/pip-3VhIfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:08 INFO - Running setup.py (path:/tmp/pip-f1dtU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:24:08 INFO - Running setup.py (path:/tmp/pip-hLXMWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:24:08 INFO - Running setup.py (path:/tmp/pip-ww54Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:10 INFO - Downloading blessings-1.6.tar.gz 10:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:24:10 INFO - Installing collected packages: blessings 10:24:10 INFO - Running setup.py install for blessings 10:24:10 INFO - Successfully installed blessings 10:24:10 INFO - Cleaning up... 10:24:10 INFO - Return code: 0 10:24:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:10 INFO - Reading from file tmpfile_stdout 10:24:10 INFO - Current package versions: 10:24:10 INFO - argparse == 1.2.1 10:24:10 INFO - blessings == 1.6 10:24:10 INFO - blobuploader == 1.2.4 10:24:10 INFO - docopt == 0.6.1 10:24:10 INFO - functools32 == 3.2.3-2 10:24:10 INFO - jsonschema == 2.5.1 10:24:10 INFO - manifestparser == 1.1 10:24:10 INFO - mozInstall == 1.12 10:24:10 INFO - mozcrash == 0.17 10:24:10 INFO - mozdebug == 0.1 10:24:10 INFO - mozdevice == 0.48 10:24:10 INFO - mozfile == 1.2 10:24:10 INFO - mozhttpd == 0.7 10:24:10 INFO - mozinfo == 0.9 10:24:10 INFO - mozleak == 0.1 10:24:10 INFO - mozlog == 3.3 10:24:10 INFO - moznetwork == 0.27 10:24:10 INFO - mozprocess == 0.23 10:24:10 INFO - mozprofile == 0.28 10:24:10 INFO - mozrunner == 6.12 10:24:10 INFO - mozscreenshot == 0.1 10:24:10 INFO - mozsystemmonitor == 0.3 10:24:10 INFO - moztest == 0.7 10:24:10 INFO - mozversion == 1.4 10:24:10 INFO - psutil == 3.1.1 10:24:10 INFO - requests == 1.2.3 10:24:10 INFO - wsgiref == 0.1.2 10:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:10 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:10 INFO - Using env: {'DISPLAY': ':0', 10:24:10 INFO - 'HOME': '/home/cltbld', 10:24:10 INFO - 'LANG': 'en_US.UTF-8', 10:24:10 INFO - 'LANGUAGE': 'en_US:en', 10:24:10 INFO - 'LOGNAME': 'cltbld', 10:24:10 INFO - 'MAIL': '/var/mail/cltbld', 10:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:10 INFO - 'MOZ_NO_REMOTE': '1', 10:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:10 INFO - 'NO_EM_RESTART': '1', 10:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:10 INFO - 'PWD': '/builds/slave/test', 10:24:10 INFO - 'SHELL': '/bin/bash', 10:24:10 INFO - 'SHLVL': '1', 10:24:10 INFO - 'TERM': 'linux', 10:24:10 INFO - 'TMOUT': '86400', 10:24:10 INFO - 'USER': 'cltbld', 10:24:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:10 INFO - '_': '/tools/buildbot/bin/python'} 10:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:24:10 INFO - Cleaning up... 10:24:10 INFO - Return code: 0 10:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:10 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 0x7f85e1ab7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, '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': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:24:10 INFO - Using env: {'DISPLAY': ':0', 10:24:10 INFO - 'HOME': '/home/cltbld', 10:24:10 INFO - 'LANG': 'en_US.UTF-8', 10:24:10 INFO - 'LANGUAGE': 'en_US:en', 10:24:10 INFO - 'LOGNAME': 'cltbld', 10:24:10 INFO - 'MAIL': '/var/mail/cltbld', 10:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:10 INFO - 'MOZ_NO_REMOTE': '1', 10:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:10 INFO - 'NO_EM_RESTART': '1', 10:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:10 INFO - 'PWD': '/builds/slave/test', 10:24:10 INFO - 'SHELL': '/bin/bash', 10:24:10 INFO - 'SHLVL': '1', 10:24:10 INFO - 'TERM': 'linux', 10:24:10 INFO - 'TMOUT': '86400', 10:24:10 INFO - 'USER': 'cltbld', 10:24:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:10 INFO - '_': '/tools/buildbot/bin/python'} 10:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:24:11 INFO - Cleaning up... 10:24:11 INFO - Return code: 0 10:24:11 INFO - Running post-action listener: _resource_record_post_action 10:24:11 INFO - Running post-action listener: _start_resource_monitoring 10:24:11 INFO - Starting resource monitoring. 10:24:11 INFO - [mozharness: 2016-08-13 17:24:11.102489Z] Finished create-virtualenv step (success) 10:24:11 INFO - [mozharness: 2016-08-13 17:24:11.102992Z] Running install step. 10:24:11 INFO - Running pre-action listener: _resource_record_pre_action 10:24:11 INFO - Running main action method: install 10:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:11 INFO - Reading from file tmpfile_stdout 10:24:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:24:11 INFO - Reading from file tmpfile_stdout 10:24:11 INFO - Output received: 10:24:11 INFO - Usage: mozinstall [options] installer 10:24:11 INFO - Options: 10:24:11 INFO - -h, --help show this help message and exit 10:24:11 INFO - -d DEST, --destination=DEST 10:24:11 INFO - Directory to install application into. [default: 10:24:11 INFO - "/builds/slave/test"] 10:24:11 INFO - --app=APP Application being installed. [default: firefox] 10:24:11 INFO - mkdir: /builds/slave/test/build/application 10:24:11 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'] 10:24:11 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 10:24:28 INFO - Reading from file tmpfile_stdout 10:24:28 INFO - Output received: 10:24:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:24:28 INFO - Running post-action listener: _resource_record_post_action 10:24:28 INFO - [mozharness: 2016-08-13 17:24:28.298401Z] Finished install step (success) 10:24:28 INFO - [mozharness: 2016-08-13 17:24:28.298683Z] Running run-tests step. 10:24:28 INFO - Running pre-action listener: _resource_record_pre_action 10:24:28 INFO - Running main action method: run_tests 10:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:24:28 INFO - Python 2.7.3 10:24:28 INFO - Return code: 0 10:24:28 INFO - grabbing minidump binary from tooltool 10:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:28 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 0x1994090>, '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 0x19979b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1997e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:24:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:24:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:24:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:24:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:24:28 INFO - Return code: 0 10:24:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:24:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:24:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:24:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:24:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:24:28 INFO - Using env: {'DISPLAY': ':0', 10:24:28 INFO - 'HOME': '/home/cltbld', 10:24:28 INFO - 'LANG': 'en_US.UTF-8', 10:24:28 INFO - 'LANGUAGE': 'en_US:en', 10:24:28 INFO - 'LOGNAME': 'cltbld', 10:24:28 INFO - 'MAIL': '/var/mail/cltbld', 10:24:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:24:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:28 INFO - 'MOZ_NO_REMOTE': '1', 10:24:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:28 INFO - 'NO_EM_RESTART': '1', 10:24:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:28 INFO - 'PWD': '/builds/slave/test', 10:24:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:24:28 INFO - 'SHELL': '/bin/bash', 10:24:28 INFO - 'SHLVL': '1', 10:24:28 INFO - 'TERM': 'linux', 10:24:28 INFO - 'TMOUT': '86400', 10:24:28 INFO - 'USER': 'cltbld', 10:24:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779', 10:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:28 INFO - '_': '/tools/buildbot/bin/python'} 10:24:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:24:28 INFO - mozversion application_buildid: 20160813073105 10:24:28 INFO - mozversion application_changeset: f50b8c335e195a6c54f144a678fd0b7913d8dd8a 10:24:28 INFO - mozversion application_display_name: Nightly 10:24:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:24:28 INFO - mozversion application_name: Firefox 10:24:28 INFO - mozversion application_remotingname: firefox 10:24:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:24:28 INFO - mozversion application_vendor: Mozilla 10:24:28 INFO - mozversion application_version: 51.0a1 10:24:28 INFO - mozversion platform_buildid: 20160813073105 10:24:28 INFO - mozversion platform_changeset: f50b8c335e195a6c54f144a678fd0b7913d8dd8a 10:24:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:24:28 INFO - mozversion platform_version: 51.0a1 10:24:28 INFO - using testdate: 1471109068 10:24:28 INFO - actual date: 1471109068 10:24:28 INFO - starting webserver on 'localhost:53698' 10:24:28 INFO - SUITE-START | Running 2 tests 10:24:28 INFO - TEST-START | dromaeo_css 10:24:28 INFO - operating with platform_type : linux_ 10:24:28 INFO - Initialising browser for dromaeo_css test... 10:24:28 INFO - TEST-INFO | started process 24865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvSJq3/profile http://localhost:53698/getInfo.html) 10:24:32 INFO - PROCESS | 24865 | __metrics Screen width/height:1600/1200 10:24:32 INFO - PROCESS | 24865 | colorDepth:24 10:24:32 INFO - PROCESS | 24865 | Browser inner width/height: 1024/697 10:24:32 INFO - PROCESS | 24865 | __metrics 10:24:33 INFO - PROCESS | 24865 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:24:33 INFO - PROCESS | 24865 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:34 INFO - TEST-INFO | 24865: exit 0 10:24:34 INFO - Browser initialized. 10:24:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:24:34 INFO - TEST-INFO | started process 24946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvSJq3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:46 INFO - PROCESS | 24946 | RSS: Main: 156102656 10:24:46 INFO - PROCESS | 24946 | 10:25:37 INFO - PROCESS | 24946 | 1471109137754 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:27:47 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53698/tests/dromaeo/cssquery-ext.html) 10:27:48 INFO - PROCESS | 24946 | RSS: Main: 272846848 10:27:48 INFO - PROCESS | 24946 | 10:30:50 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-ext.html (next: http://localhost:53698/tests/dromaeo/cssquery-jquery.html) 10:30:51 INFO - PROCESS | 24946 | RSS: Main: 242880512 10:30:51 INFO - PROCESS | 24946 | 10:33:53 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53698/tests/dromaeo/cssquery-mootools.html) 10:33:54 INFO - PROCESS | 24946 | RSS: Main: 213430272 10:33:54 INFO - PROCESS | 24946 | 10:36:56 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53698/tests/dromaeo/cssquery-prototype.html) 10:36:56 INFO - PROCESS | 24946 | RSS: Main: 243372032 10:36:56 INFO - PROCESS | 24946 | 10:39:59 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53698/tests/dromaeo/cssquery-yui.html) 10:40:00 INFO - PROCESS | 24946 | RSS: Main: 181911552 10:40:00 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | Cycle 1(1): loaded http://localhost:53698/tests/dromaeo/cssquery-yui.html (next: http://localhost:53698/tests/dromaeo/cssquery-dojo.html) 10:43:03 INFO - PROCESS | 24946 | RSS: Main: 274890752 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | __start_tp_report 10:43:03 INFO - PROCESS | 24946 | _x_x_mozilla_page_load 10:43:03 INFO - PROCESS | 24946 | _x_x_mozilla_page_load_details 10:43:03 INFO - PROCESS | 24946 | |i|pagename|runs| 10:43:03 INFO - PROCESS | 24946 | |0;dojo.html;3037.377337645783;3054.6639869614323;3075.7078077582623;3084.8766049358014;3089.2122508760262;5120.257562653423;5234.241035049916;5336.893262134759;5415.214793854893;5444.999999999995;5346.492083252085;5350.732463376835;5374.7850085996515;5410.1073322901675;5439.401665816757;4806.927896081553;4821.204501257288;4912.828051018215;4921.409430868301;5017.52333528316;4936.35827342445;4973.925391119136;4978.900421991558;4987.476314986929;4992.525710057539;4666.020135771492;4772.973810630697;4797.52024797521;4830.686005409637;4911.361523002005;4800.039992001613;4844.878878028042;4846.079244943449;4912.287718280829;4956.08312462192;4894.36373271476;4900.995295964319;4901.044296362211;4905;4939.481354457766;5161.870953226162;5293.655912365684;5350.0904846176245;5355.169948657965;5400.351957765093;5783.479486846204;5801.071828507418;5822.068469044975;5826.242588463515;5827.708614569255;5513.751881165357;5833.7374818133285;5837.678927658977;5870.677112758796;5873.2658417697785;5331.893362132736;5373.59698022646;5377.381601115882;5382.111951527954;5435.211894275308;5952;5955.880882382415;5962.761489540457;5964.7315870785915;5965.105234214816;5412.025835349675;5723;5723.742431590588;5729.770809167587;5730.455606717355;5694.117411801178;5730.942690573041;5735.971320143372;5781.161731548902;5832.88334233313;5720.399358067426;5766.163906233573;5766.855828604234;5773.480386765127;5775.047117225695;5534.059209934321;5735.8566035849435;5761.337446193657;5794.739236734357;5801.88396232073;4320.4383430153875;4385;4396.054848207651;4406.405135306757;4417.536158703354;3927.9018024549614;3933.547642021147;3949.6840252779707;3966.0283230608684;3969.1466334737593;5214.374275086938;5510.201020851954;5514.228008078872;5524.116141417354;5524.226608274845;5719.256496655408;5789.45000224978;5789.986752318412;5818;5867.70661466925;5384.461553844584;5484.670919744828;5487;5488.890222195534;5496.422875598085;4747.454042785055;5017.523335283142;5032.119379108714;5046.6719663221775;5091.618128640367;5955.702214889325;5981.581289309794;5984.431479009487;6033.155358249761;6077.544184186116;5794.188813566188;5817.418258174149;5826.009578371772;5826.912596310974;5838.357780644211;5687.77248910039;5963.522918166623;6018.789342372996;6041.154238406539;6043.456088952015;5541.3904470507405;5550.4449555044175;5562.610617256915;5620.241267428844;5643.435656434323;5664.631798933056;5693.1460280956535;5703.857403564944;5714.399988001366;5716.085426331933;5422.267993820784;5595.132754423071;5599.04816181242;5602.635828671123;5606.495415412469;5520.91718624229;5542.362628297636;5554.972225138848;5602.747876345493;5632.943670563406;5574.749136288796;5581.6371935824045;5585.972070139624;5587.944120558905;5591.692456914746;5384.407715151252;5629.043062679272;5677.034904066401;5682.318121825242;5685.914711279252;5192.688438693691;5469.988052210354;5481.260029896072;5488.5334746545395;5573.554115670818 10:43:03 INFO - PROCESS | 24946 | |1;ext.html;568.843568018795;597.1908064572505;599.0804115682429;614.6631077406639;628.3308276685328;32226.83886580567;42823.57176428235;43339.34990975134;43595;43771.56228437715;40630.59369406305;43843;44177;44286.55713442864;44355;7971.481853679521;8764.56177191141;8902.866457003118;8933.196012358887;10538.525766340534;10445.895541044569;10825.242233043651;10840.078593319577;10842.837357439645;10855.782884342349;10872.891271087306;10929;10944.835827462555;10960.342379457257;10960.890391096107;10820.404877731722;10864.076553492883;10870.728231794228;10879.782404351949;10883.346999179996;10680.572777088908;10723.731906702316;10744.623938162127;10746.946265268702;10752.946235268852;41543.545975891;41947.37078943818;41965.16069678589;41979.7901010493;42075;3193.616765988096;3529.6470352964498;3542.6103128655827;3550.1302180965827;3732.9920921351354;30017.249568760955;30195.547066793795;30708.692913070805;31540.36919261602;34960.10558521809;4221.472315960505;4235.703500754948;4246.108317253381;4340.717853339523;4365.192439398721;349279;351332;355403;355934;357487;57115.71442142763;57437;57476.13785793216;57539.42460575424;57559;59922;60042;60250.69874650687;60306.698466508264;60370.09444858331;16683.416080437128;17120.14399280031;17200.82799171992;17214.65570688579;17307.30770769155;13316;13349.199048057148;13358.265295408652;13382;13400.32998350098;15897.761533577006;16092.436764713413;16196.109213993344;16229.756553651705;16269.918650406673;5661.830145095653;5799.8250656004;5821.621594596338;5833.416658334218;5854.356020837705;947.7062110745691;1008.7881544875659;1070.5450183671908;1095.4686976816238;1128.08061429936;32348.83825580857;32488.350232995206;32576.511352329733;32965.61703983403;32974.67025329764;818.5620692929373;1080.0927221134284;1096.9561217551368;1129.678041758095;1201.381288636353;17067.658646826992;17503.64992700139;17558.29766809339;17579.472615821545;17607.647847042987;499008;504729.57433831133;506267;507134;507140;57844.421555783905;57987.71006144942;58037.12944305839;58077.12884306739;58101.70949145312;1338.5382043195082;1352.8444228913604;1398.161103337989;1399.4751968011994;1406.5077222972081;30850.69149308568;32253.677463225067;32551;33268.66731332656;33322.83338583291;56970;57213.14180287216;57310;57370.713146434;57682.134767979354;422852;426056;426234;426271;426688;25233.495330092926;27811.860940695977;28132.85933570319;28204.85897570499;28576.42847143087;48648.75675621599;49112.263316051;50034.249486258464;50043.74978125086;50504.49495505145;39841.40237896492;41286.58713412828;42048;42805.57194428016;43690;40200.195996080496;41061;41085;41662.58337416587;42107.57892421159;42030.36954445625;42229;42525.78737106295;42713.1457370857;42888;33986.83006584951;36323.45514817227;37538.436923446716;38446.615533844306;38751;28101;28690.56964145581;28709.71290287154;28850;28920.276993075342 10:43:03 INFO - PROCESS | 24946 | |2;jquery.html;385.4237914318095;395.96238357356043;412.60183922514767;414.5315793153736;429.56828387470586;15607.843921560796;19425.028748562585;19628.705569416452;19852.60294794105;21156.365309040753;19840;20066.49833754157;20157.899210503965;20343.79656203441;20603.1758729651;5636.887262254762;5691.886162276752;5774.249347584808;5781.768729250825;5824.825255242349;4218.198542276973;5669.8299051028325;5757.856053598652;5759.942400575983;5759.942400576004;5996.940030599681;6226.190595222637;6261.655608941506;6379.904301435482;6390.146857411345;6151.138840562303;6340.936590634081;6359.618422894618;6377.107204991305;6430.614163150226;5623.903338848926;5652.547796176337;5661.688607126606;5712.514436272922;5714.485696287354;23925.64111538328;24508.509829803304;24575.13987010464;24750.381240468952;24929.750702492925;2350.9999999999827;2372.0511795281855;2436.7319594844553;2472.208893154191;2543.5421624107653;14487.203203823785;14949.177795221258;15147.54557363281;15210.847891521054;15901.1254381009;1859.2470049629922;1947.123794292574;1958.8726732762325;1982.900854957261;1995.2712072388533;79931.20068799295;80608;81378;81698.59150704209;83089.58455207746;10733.892661073289;10832.729181770519;10999.61501347449;11084.646481723621;11212.719682008015;15471.071735695668;15508;15510.302036408162;15512.379504819906;15555.84444155544;8216.26053655174;8400.495970241805;8431.28334091609;8662.783430414163;8681.262092722063;8046.235607617267;8175.959120204361;8208.384371172186;8331.291840193651;8393.118722534167;6759.121314229119;6795.1845778506895;6817.386435220854;6893;6912.306484911129;1954.990225048894;1958.6866101423705;1958.9118489667999;2023.605396947581;2030.5634288628016;1003.4932359158578;1003.6286573967678;1034.4517405774952;1042.5100202904623;1093.2456604942565;19954.70067948982;21113.68329475059;21224.469388265108;21228.893855530623;21308.36074917755;1007.3351587951917;1022.9744256393501;1025.7999690060515;1039.3555995282973;1056.0970370333407;9154.954225228832;11090.667279981613;11853.288802671867;12095.21381110225;12123.33321667299;478854;514350;518242;519834;523156;81867.5906620475;82886;84192.57903710443;85839;85842;1028.2596530498029;1037.3464717228098;1040.9375437473625;1051.9631812886512;1059.1685526861377;17738;17759.467215983543;17771.289148433916;18938.715919260947;19375;40001.399978999754;43635.34546981861;43901.78049109734;44211.33682994694;44426.55573444354;55084.44915550954;57447;57944;59530.70234648799;59581.40418595932;8337.833243334979;8369.49783013021;8638.524881131598;11752.177347585586;11883;12101.576444824388;12860.485580576673;13381.130226535244;13739;13749.106308089942;11641.359725214856;11849.940750296539;11868.169228154291;12193.634190974284;12345.197562158432;11648.068154547447;11956.461959211681;11964.702443181772;11990.220635658654;12301.75396492083;12065.517379304729;12378.133530652767;12514.74970500603;12526.812097818722;12616.49534018629;12075.154739168174;12284.570040048555;12287.1399002069;12434.197041429123;12605.87394126047;12020.939895300467;12038.976686981705;12149.817752733892;12278.201916875374;12448.128630996105 10:43:03 INFO - PROCESS | 24946 | |3;mootools.html;1304.0806231606718;1447.9710405791884;1491.2171110167164;1576.2591581956476;1717.261577521666;7984.441089123764;8215.83568328633;8277.42058055937;8412.789680257996;8463.66145354185;8322.83354332913;8399.244068033875;8401.83196336073;8414.116517765638;8424.620892059856;2381.8809059546998;2417.3231495181376;2421.5762241607736;2424.018272599591;2426.7815896569305;2383.7377888432347;2390.306811024801;2454.6808914841044;2459.6802415685934;2462.5936720441105;2398.0887262840097;2407.5064611754547;2410.5419970205694;2438.1100898172217;2447.449323902126;2351.929442116739;2357.9764202358015;2363.2319496163814;2366.7278262999716;2406.2540612410207;2307.4462129088897;2321.9071237150492;2321.918732844359;2325.081592770846;2329.138218859016;8348.457350272212;8356.540390278533;8396.118407567179;8407.45351552147;8489.61796719149;5313.468653134694;5519.116941289374;5519.144532597454;5521.420250873641;5530.640508366983;3465.549478567795;3467.514547963287;3528.1708798432346;3537.964620353789;3569.3575156471825;1120.9327440353604;1126.3129491010477;1133.1274918312936;1148.0585919545977;1156.4853640130145;11427.48576314068;11451.770964580744;11493.827592586034;11504.02215811657;11550.191486595942;4448.799804008828;4592.425946756655;4697.412823397075;4750.8337208197545;4765;9100.635974561075;9174.587143578556;9183.265338772882;9187.035361287102;9193.448393096436;5281.973590132102;5314.946850531523;5316.548093412103;5316.973415132977;5318;4196.139791342828;4854.17479028566;4928.408590969107;4999.375078115236;5043.344365232496;3705.814709264526;3822.866199682998;3898.590647981978;3921.627445392683;3969.126792105732;1191.8450601421932;1213.3266037349356;1215.8784121587948;1230.5323976888726;1233.6730766346925;977.5552123783662;997.8952210017989;1000.7298029531986;1023.6110278094277;1033.1476531861244;6088.543359247986;6113.877722445526;6147.815565533041;6158.261008678987;6310.905336419957;490.1422510606439;491.8991606720614;507.47983317100267;513.7611010879884;514.6028532534114;4205.074883525619;4207.431996680471;4283.978580107079;4353.7170083945075;4368.650507959355;10128.189744820396;10394.740131496774;10626;10721.678349649523;11034.117270618332;10806.675799725863;10815.459227038617;10831;10838.566457341618;10843.240973131962;7788.221177882167;8282.4202305838;8330.916690833013;8356.331493480508;8363.540005299767;5981.880362392641;6043.36544662804;6108.175396321618;6174.073888916699;6316.526260530387;9545.713628591153;9744.025597440483;9747.707568772948;9870.161036311994;9895.25785566071;9947.502624868872;9970.601175952881;10018.899811001796;10030.699079027641;10038.749031274276;6570.310117437792;6739.966300168468;6754.425873800586;7758.844823103619;7836.412269079956;7347.7795666130105;8114.269715725613;8409.87385189235;8418.494890306602;8499.447535910145;7647.541147530944;7674.4533545848035;7820.217978202134;7906.841863162819;7939.563324017235;7470.8505829882015;7588.734394296173;7604.429667774828;7671.3862890967475;7826.530408175528;7063.752768653072;7109.893351599833;7127.607981561064;7130.786076417716;7166.140063192451;5182.300389447527;5225.294585230945;5259.526642602184;5264.578833693372;5479.6164268500825;4977.751112444291;5022.547970682656;5069.645124841226;5168.767405466839;5261.421243663118 10:43:03 INFO - PROCESS | 24946 | |4;prototype.html;303.8040463900784;314.8520195508111;321.8246055899535;322.46953761063065;326.225215114104;5057.418396884359;5096.572959571326;5283.603729720272;5327.786888524459;5362.954223926341;5097.286379906816;5185.351831021122;5224.399194092681;5282.07563676357;5291.259223708684;4147.440095587087;4156.833726650931;4163.3130533461945;4189.937150942746;4202.453681021463;4041.555428902818;4116.464859568252;4120.649744771698;4149.315362965107;4167.645515207554;4085.1829634073156;4091.509018917734;4096.97951510242;4107.158032603309;4130.896727581804;4087.305158123111;4102.774347410891;4107.835686572518;4120.423140760296;4122.134351786129;3664.3221004114325;3688.61269566697;3696.8890933272046;3700.611435799256;3726.6273372662517;4926.4088309403105;5082.923756143661;5104.285400043997;5109.182530795092;5143.254228136937;4685.554872287127;4720.858374248778;4728.361671174382;4736.336912832172;4736.9526304736855;5378.300820893259;5489.670619762787;5490.203920431555;5494.862628434321;5517.5585953123655;3955.6155345629086;4015.6586690131376;4019.075612609087;4025.496812898388;4044.7573145611063;5670;5680.488756011938;5685.40303268155;5689;5700.686462244575;4135.29699951009;4142.855000075043;4145.751254924654;4151.626353628188;4166;3871.825767840454;4035.8991025224605;4036.1725846201457;4052.7163098583405;4209.642180414699;4640.559146881041;4644.187267228222;4656.906861862743;4663.440387153563;4667.649926255544;5498.147787093007;5538.556915446755;5551.611387202938;5590.273264475592;5635.859103522363;1300.1873828856965;1321.2270821569298;1337.3112846883862;1348.9797653035212;1361.1152750712117;926.7266156483853;937.2642475656713;960.6637676813059;968.5157421289356;973.9805203895883;5284.841454756363;5293.232481290192;5295.682259064469;5305.734713264322;5336.252924590561;5582.162675598693;5610.1584762285165;5620.91568626471;5637.774489020475;5644.604877658525;5176.197689358156;5225.634205605647;5260.210968354778;5332.146856502941;5333.7066461345;2611.164427383257;2616.306678730138;2623.921282361532;2625.698044724843;2648.708642049373;5085.593152547787;5086.898262034739;5091.389033315952;5125.846224613268;5127.53852153308;5008.148614735431;5046.722430266371;5407.378151512547;5772.612814261108;5830.970845145832;5896.970515147397;5919.792807251725;5920.881582368328;5923.348431672513;5953.76184952597;5501.001953935035;5659.387074683696;5710.743016564182;5754.223179870832;5771.480566749013;5646.802361917313;5658;5664.572933375413;5671.773129074956;5680.857978550569;5881.088431293157;5896.233489646319;5903.527717782653;5920.79277225295;6001.849953751192;3865.96134038656;4048.2308361411237;4064.349704047338;4074.5925407459017;4083.8570650027104;5402.837914862561;5681;5683.829485115453;5694.629849059798;5726.141078838207;5451.236826844166;5578;5581.441855814386;5603.607747457639;5623.550115990629;5541.5289700375915;5564.55483561306;5578.609497335147;5622.2128901954575;5637.3235211774845;5284.841454756363;5541.418151094238;5542.2795036644975;5556.444355564411;5575.177471487215;5604.915926261027;5607.635503692247;5632.098864181711;5641.492265696107;5649.85875353103;5487.4238204987905;5509.972450137724;5530.557555395479;5547.639403438763;5560.220729366564 10:43:03 INFO - PROCESS | 24946 | |5;yui.html;782.4170992610506;829.4898637338039;844.0968164064453;872.7905302727347;874.3879284500849;14645;17742.290308387648;17743.467695969142;17745.20146593403;17748.822511774877;15880.920595397036;15988.840111598909;16002.5999350016;16008.759868601981;16013.35946562136;824.3775949158392;848.2281124177;849.8300339932007;850.8766228896807;851.1786126388034;812.6789917982394;814.3851392198882;814.5927036481759;814.8533264012505;815.0097631377874;703.9788806335819;848.4654667559429;861.5390765940223;871.6861929705301;872.7381785464368;874.623911717961;874.8294082653916;874.9650013999433;875.1423604867202;875.4790899414838;629.298332359416;636.2810024672091;637.665225756477;637.7289651897971;638.0078977190467;12201.694957626041;15121.697566048728;15663.21683915811;15753.842461575352;16146.273417696231;14615;14854.554363369009;15329.616759580987;15539.14534700591;15697.215139242991;12864.09951303409;12911.612651620373;13198.60404187876;13255.668608284774;13660.316984150753;3902.1610353774076;3974.225026119908;3987.7208595398333;4038.9798051009557;4123.8556650517085;83914.58042709748;85941.57029214814;87082;88429.55785221097;88451.55774221088;11598;11608.709782255342;11712.941435292769;11745.47145378443;12205.20666156697;24257.055355486336;24508.38729031753;24517.63223551648;24532;24559.38601534976;8549.187827156535;8804.075572064969;9000.36997410188;9153;9161.45031298111;4994.875128121754;5006.4743201964;5105.591552675777;5183.170692689152;5344.732763361816;3703.7222208334483;3818.9045273868373;3836.0985168485386;3849.3263678856088;3850.403187505941;574.3165632896839;589.1957478042527;593.5103539579864;600.0489224579004;600.9128676341993;613.5459759777822;622.6077571130159;633.597665482422;636.6721138613618;709.3332267668375;9692.854607180898;9937.602495900082;9989.400635961865;10396.896031039743;10753.569857205624;670.6747227594612;689.6620655878684;732.6263605561202;734.9853002939911;744.7356188553094;4722.5513576210205;5019.698818070928;5099.082165210298;5099.8725031873755;5133.563647089964;96706;98772;126052;134274;134806;97055.51472242735;100366;100369.49815250876;100952;101239;85165;88101.5594922034;88239;89837.20325593321;90799.99999999868;10041.698749037541;10120.94939525327;10241.23190760681;10286.125679317342;10361.84457233127;34716.826415867756;35564.28871422609;49447.25829112638;49756;50635.24047139222;50435;62589.61872668869;66634.66682666556;68348.44501314455;72490.63754681403;13146.80279795823;13229.564278889266;13470.393832277376;13484.32578371058;13992.930035349758;15739.213039348217;15820.762688559911;15969.520914372588;16070.35718571244;16144.838551614333;14466.421343146156;14830.925845370704;14881.330340134937;14986.47547335838;15014.699706006037;14166.858331416553;14562.635934101732;14865.108093514424;15019.474318398803;15045.699086018438;14242.857571424152;14554.85445145535;14614.269286535844;15092.924535377253;15108.622284442978;11250.762416134055;11840.28958262507;11967.401629918644;11976.28142311464;12718.809217861924;11865.347405892759;12598.811017834923;12690.302033388252;12838.614841554769;12897.226166430044 10:43:03 INFO - PROCESS | 24946 | __end_tp_report 10:43:03 INFO - PROCESS | 24946 | __start_cc_report 10:43:03 INFO - PROCESS | 24946 | _x_x_mozilla_cycle_collect,1037 10:43:03 INFO - PROCESS | 24946 | __end_cc_report 10:43:03 INFO - PROCESS | 24946 | __startTimestamp1471110183821__endTimestamp 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | ------- Summary: start ------- 10:43:03 INFO - PROCESS | 24946 | Number of tests: 6 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#0] dojo.html Cycles:165 Average:5340.64 Median:5524.12 stddev:616.90 (11.2%) stddev-sans-first:591.74 10:43:03 INFO - PROCESS | 24946 | Values: 3037.4 3054.7 3075.7 3084.9 3089.2 5120.3 5234.2 5336.9 5415.2 5445.0 5346.5 5350.7 5374.8 5410.1 5439.4 4806.9 4821.2 4912.8 4921.4 5017.5 4936.4 4973.9 4978.9 4987.5 4992.5 4666.0 4773.0 4797.5 4830.7 4911.4 4800.0 4844.9 4846.1 4912.3 4956.1 4894.4 4901.0 4901.0 4905.0 4939.5 5161.9 5293.7 5350.1 5355.2 5400.4 5783.5 5801.1 5822.1 5826.2 5827.7 5513.8 5833.7 5837.7 5870.7 5873.3 5331.9 5373.6 5377.4 5382.1 5435.2 5952.0 5955.9 5962.8 5964.7 5965.1 5412.0 5723.0 5723.7 5729.8 5730.5 5694.1 5730.9 5736.0 5781.2 5832.9 5720.4 5766.2 5766.9 5773.5 5775.0 5534.1 5735.9 5761.3 5794.7 5801.9 4320.4 4385.0 4396.1 4406.4 4417.5 3927.9 3933.5 3949.7 3966.0 3969.1 5214.4 5510.2 5514.2 5524.1 5524.2 5719.3 5789.5 5790.0 5818.0 5867.7 5384.5 5484.7 5487.0 5488.9 5496.4 4747.5 5017.5 5032.1 5046.7 5091.6 5955.7 5981.6 5984.4 6033.2 6077.5 5794.2 5817.4 5826.0 5826.9 5838.4 5687.8 5963.5 6018.8 6041.2 6043.5 5541.4 5550.4 5562.6 5620.2 5643.4 5664.6 5693.1 5703.9 5714.4 5716.1 5422.3 5595.1 5599.0 5602.6 5606.5 5520.9 5542.4 5555.0 5602.7 5632.9 5574.7 5581.6 5586.0 5587.9 5591.7 5384.4 5629.0 5677.0 5682.3 5685.9 5192.7 5470.0 5481.3 5488.5 5573.6 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#1] ext.html Cycles:180 Average:59528.36 Median:20028.22 stddev:114348.64 (570.9%) stddev-sans-first:114583.73 10:43:03 INFO - PROCESS | 24946 | Values: 568.8 597.2 599.1 614.7 628.3 32226.8 42823.6 43339.3 43595.0 43771.6 40630.6 43843.0 44177.0 44286.6 44355.0 7971.5 8764.6 8902.9 8933.2 10538.5 10445.9 10825.2 10840.1 10842.8 10855.8 10872.9 10929.0 10944.8 10960.3 10960.9 10820.4 10864.1 10870.7 10879.8 10883.3 10680.6 10723.7 10744.6 10746.9 10752.9 41543.5 41947.4 41965.2 41979.8 42075.0 3193.6 3529.6 3542.6 3550.1 3733.0 30017.2 30195.5 30708.7 31540.4 34960.1 4221.5 4235.7 4246.1 4340.7 4365.2 349279.0 351332.0 355403.0 355934.0 357487.0 57115.7 57437.0 57476.1 57539.4 57559.0 59922.0 60042.0 60250.7 60306.7 60370.1 16683.4 17120.1 17200.8 17214.7 17307.3 13316.0 13349.2 13358.3 13382.0 13400.3 15897.8 16092.4 16196.1 16229.8 16269.9 5661.8 5799.8 5821.6 5833.4 5854.4 947.7 1008.8 1070.5 1095.5 1128.1 32348.8 32488.4 32576.5 32965.6 32974.7 818.6 1080.1 1097.0 1129.7 1201.4 17067.7 17503.6 17558.3 17579.5 17607.6 499008.0 504729.6 506267.0 507134.0 507140.0 57844.4 57987.7 58037.1 58077.1 58101.7 1338.5 1352.8 1398.2 1399.5 1406.5 30850.7 32253.7 32551.0 33268.7 33322.8 56970.0 57213.1 57310.0 57370.7 57682.1 422852.0 426056.0 426234.0 426271.0 426688.0 25233.5 27811.9 28132.9 28204.9 28576.4 48648.8 49112.3 50034.2 50043.7 50504.5 39841.4 41286.6 42048.0 42805.6 43690.0 40200.2 41061.0 41085.0 41662.6 42107.6 42030.4 42229.0 42525.8 42713.1 42888.0 33986.8 36323.5 37538.4 38446.6 38751.0 28101.0 28690.6 28709.7 28850.0 28920.3 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#2] jquery.html Cycles:180 Average:30007.54 Median:20858.43 stddev:83907.18 (402.3%) stddev-sans-first:84113.08 10:43:03 INFO - PROCESS | 24946 | Values: 385.4 396.0 412.6 414.5 429.6 15607.8 19425.0 19628.7 19852.6 21156.4 19840.0 20066.5 20157.9 20343.8 20603.2 5636.9 5691.9 5774.2 5781.8 5824.8 4218.2 5669.8 5757.9 5759.9 5759.9 5996.9 6226.2 6261.7 6379.9 6390.1 6151.1 6340.9 6359.6 6377.1 6430.6 5623.9 5652.5 5661.7 5712.5 5714.5 23925.6 24508.5 24575.1 24750.4 24929.8 2351.0 2372.1 2436.7 2472.2 2543.5 14487.2 14949.2 15147.5 15210.8 15901.1 1859.2 1947.1 1958.9 1982.9 1995.3 79931.2 80608.0 81378.0 81698.6 83089.6 10733.9 10832.7 10999.6 11084.6 11212.7 15471.1 15508.0 15510.3 15512.4 15555.8 8216.3 8400.5 8431.3 8662.8 8681.3 8046.2 8176.0 8208.4 8331.3 8393.1 6759.1 6795.2 6817.4 6893.0 6912.3 1955.0 1958.7 1958.9 2023.6 2030.6 1003.5 1003.6 1034.5 1042.5 1093.2 19954.7 21113.7 21224.5 21228.9 21308.4 1007.3 1023.0 1025.8 1039.4 1056.1 9155.0 11090.7 11853.3 12095.2 12123.3 478854.0 514350.0 518242.0 519834.0 523156.0 81867.6 82886.0 84192.6 85839.0 85842.0 1028.3 1037.3 1040.9 1052.0 1059.2 17738.0 17759.5 17771.3 18938.7 19375.0 40001.4 43635.3 43901.8 44211.3 44426.6 55084.4 57447.0 57944.0 59530.7 59581.4 8337.8 8369.5 8638.5 11752.2 11883.0 12101.6 12860.5 13381.1 13739.0 13749.1 11641.4 11849.9 11868.2 12193.6 12345.2 11648.1 11956.5 11964.7 11990.2 12301.8 12065.5 12378.1 12514.7 12526.8 12616.5 12075.2 12284.6 12287.1 12434.2 12605.9 12020.9 12039.0 12149.8 12278.2 12448.1 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#3] mootools.html Cycles:180 Average:5690.40 Median:2788.56 stddev:3138.90 (112.6%) stddev-sans-first:3130.39 10:43:03 INFO - PROCESS | 24946 | Values: 1304.1 1448.0 1491.2 1576.3 1717.3 7984.4 8215.8 8277.4 8412.8 8463.7 8322.8 8399.2 8401.8 8414.1 8424.6 2381.9 2417.3 2421.6 2424.0 2426.8 2383.7 2390.3 2454.7 2459.7 2462.6 2398.1 2407.5 2410.5 2438.1 2447.4 2351.9 2358.0 2363.2 2366.7 2406.3 2307.4 2321.9 2321.9 2325.1 2329.1 8348.5 8356.5 8396.1 8407.5 8489.6 5313.5 5519.1 5519.1 5521.4 5530.6 3465.5 3467.5 3528.2 3538.0 3569.4 1120.9 1126.3 1133.1 1148.1 1156.5 11427.5 11451.8 11493.8 11504.0 11550.2 4448.8 4592.4 4697.4 4750.8 4765.0 9100.6 9174.6 9183.3 9187.0 9193.4 5282.0 5314.9 5316.5 5317.0 5318.0 4196.1 4854.2 4928.4 4999.4 5043.3 3705.8 3822.9 3898.6 3921.6 3969.1 1191.8 1213.3 1215.9 1230.5 1233.7 977.6 997.9 1000.7 1023.6 1033.1 6088.5 6113.9 6147.8 6158.3 6310.9 490.1 491.9 507.5 513.8 514.6 4205.1 4207.4 4284.0 4353.7 4368.7 10128.2 10394.7 10626.0 10721.7 11034.1 10806.7 10815.5 10831.0 10838.6 10843.2 7788.2 8282.4 8330.9 8356.3 8363.5 5981.9 6043.4 6108.2 6174.1 6316.5 9545.7 9744.0 9747.7 9870.2 9895.3 9947.5 9970.6 10018.9 10030.7 10038.7 6570.3 6740.0 6754.4 7758.8 7836.4 7347.8 8114.3 8409.9 8418.5 8499.4 7647.5 7674.5 7820.2 7906.8 7939.6 7470.9 7588.7 7604.4 7671.4 7826.5 7063.8 7109.9 7127.6 7130.8 7166.1 5182.3 5225.3 5259.5 5264.6 5479.6 4977.8 5022.5 5069.6 5168.8 5261.4 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#4] prototype.html Cycles:180 Average:4628.05 Median:5282.84 stddev:1374.04 (26.0%) stddev-sans-first:1339.01 10:43:03 INFO - PROCESS | 24946 | Values: 303.8 314.9 321.8 322.5 326.2 5057.4 5096.6 5283.6 5327.8 5363.0 5097.3 5185.4 5224.4 5282.1 5291.3 4147.4 4156.8 4163.3 4189.9 4202.5 4041.6 4116.5 4120.6 4149.3 4167.6 4085.2 4091.5 4097.0 4107.2 4130.9 4087.3 4102.8 4107.8 4120.4 4122.1 3664.3 3688.6 3696.9 3700.6 3726.6 4926.4 5082.9 5104.3 5109.2 5143.3 4685.6 4720.9 4728.4 4736.3 4737.0 5378.3 5489.7 5490.2 5494.9 5517.6 3955.6 4015.7 4019.1 4025.5 4044.8 5670.0 5680.5 5685.4 5689.0 5700.7 4135.3 4142.9 4145.8 4151.6 4166.0 3871.8 4035.9 4036.2 4052.7 4209.6 4640.6 4644.2 4656.9 4663.4 4667.6 5498.1 5538.6 5551.6 5590.3 5635.9 1300.2 1321.2 1337.3 1349.0 1361.1 926.7 937.3 960.7 968.5 974.0 5284.8 5293.2 5295.7 5305.7 5336.3 5582.2 5610.2 5620.9 5637.8 5644.6 5176.2 5225.6 5260.2 5332.1 5333.7 2611.2 2616.3 2623.9 2625.7 2648.7 5085.6 5086.9 5091.4 5125.8 5127.5 5008.1 5046.7 5407.4 5772.6 5831.0 5897.0 5919.8 5920.9 5923.3 5953.8 5501.0 5659.4 5710.7 5754.2 5771.5 5646.8 5658.0 5664.6 5671.8 5680.9 5881.1 5896.2 5903.5 5920.8 6001.8 3866.0 4048.2 4064.3 4074.6 4083.9 5402.8 5681.0 5683.8 5694.6 5726.1 5451.2 5578.0 5581.4 5603.6 5623.6 5541.5 5564.6 5578.6 5622.2 5637.3 5284.8 5541.4 5542.3 5556.4 5575.2 5604.9 5607.6 5632.1 5641.5 5649.9 5487.4 5510.0 5530.6 5547.6 5560.2 10:43:03 INFO - PROCESS | 24946 | 10:43:03 INFO - PROCESS | 24946 | [#5] yui.html Cycles:180 Average:21289.76 Median:3876.28 stddev:30416.22 (784.7%) stddev-sans-first:30462.56 10:43:03 INFO - PROCESS | 24946 | Values: 782.4 829.5 844.1 872.8 874.4 14645.0 17742.3 17743.5 17745.2 17748.8 15880.9 15988.8 16002.6 16008.8 16013.4 824.4 848.2 849.8 850.9 851.2 812.7 814.4 814.6 814.9 815.0 704.0 848.5 861.5 871.7 872.7 874.6 874.8 875.0 875.1 875.5 629.3 636.3 637.7 637.7 638.0 12201.7 15121.7 15663.2 15753.8 16146.3 14615.0 14854.6 15329.6 15539.1 15697.2 12864.1 12911.6 13198.6 13255.7 13660.3 3902.2 3974.2 3987.7 4039.0 4123.9 83914.6 85941.6 87082.0 88429.6 88451.6 11598.0 11608.7 11712.9 11745.5 12205.2 24257.1 24508.4 24517.6 24532.0 24559.4 8549.2 8804.1 9000.4 9153.0 9161.5 4994.9 5006.5 5105.6 5183.2 5344.7 3703.7 3818.9 3836.1 3849.3 3850.4 574.3 589.2 593.5 600.0 600.9 613.5 622.6 633.6 636.7 709.3 9692.9 9937.6 9989.4 10396.9 10753.6 670.7 689.7 732.6 735.0 744.7 4722.6 5019.7 5099.1 5099.9 5133.6 96706.0 98772.0 126052.0 134274.0 134806.0 97055.5 100366.0 100369.5 100952.0 101239.0 85165.0 88101.6 88239.0 89837.2 90800.0 10041.7 10120.9 10241.2 10286.1 10361.8 34716.8 35564.3 49447.3 49756.0 50635.2 50435.0 62589.6 66634.7 68348.4 72490.6 13146.8 13229.6 13470.4 13484.3 13992.9 15739.2 15820.8 15969.5 16070.4 16144.8 14466.4 14830.9 14881.3 14986.5 15014.7 14166.9 14562.6 14865.1 15019.5 15045.7 14242.9 14554.9 14614.3 15092.9 15108.6 11250.8 11840.3 11967.4 11976.3 12718.8 11865.3 12598.8 12690.3 12838.6 12897.2 10:43:03 INFO - PROCESS | 24946 | -------- Summary: end -------- 10:43:03 INFO - PROCESS | 24946 | 10:43:04 INFO - TEST-INFO | 24946: exit 0 10:43:04 INFO - TEST-OK | dromaeo_css | took 1116045ms 10:43:04 INFO - TEST-START | kraken 10:43:04 INFO - operating with platform_type : linux_ 10:43:04 INFO - Initialising browser for kraken test... 10:43:04 INFO - TEST-INFO | started process 25250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFhMUU/profile http://localhost:53698/getInfo.html) 10:43:08 INFO - PROCESS | 25250 | __metrics Screen width/height:1600/1200 10:43:08 INFO - PROCESS | 25250 | colorDepth:24 10:43:08 INFO - PROCESS | 25250 | Browser inner width/height: 1024/697 10:43:08 INFO - PROCESS | 25250 | __metrics 10:43:09 INFO - PROCESS | 25250 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:43:09 INFO - PROCESS | 25250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:10 INFO - TEST-INFO | 25250: exit 0 10:43:10 INFO - Browser initialized. 10:43:10 INFO - Running cycle 1/1 for kraken test... 10:43:10 INFO - TEST-INFO | started process 25332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFhMUU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:22 INFO - PROCESS | 25332 | RSS: Main: 155693056 10:43:22 INFO - PROCESS | 25332 | 10:43:24 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53698/tests/kraken/driver.html?testName=audio-beat-detection) 10:43:25 INFO - PROCESS | 25332 | RSS: Main: 203481088 10:43:25 INFO - PROCESS | 25332 | 10:43:28 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53698/tests/kraken/driver.html?testName=audio-dft) 10:43:28 INFO - PROCESS | 25332 | RSS: Main: 194793472 10:43:28 INFO - PROCESS | 25332 | 10:43:32 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53698/tests/kraken/driver.html?testName=audio-fft) 10:43:32 INFO - PROCESS | 25332 | RSS: Main: 275976192 10:43:32 INFO - PROCESS | 25332 | 10:43:34 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53698/tests/kraken/driver.html?testName=audio-oscillator) 10:43:35 INFO - PROCESS | 25332 | RSS: Main: 186257408 10:43:35 INFO - PROCESS | 25332 | 10:43:37 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:43:38 INFO - PROCESS | 25332 | RSS: Main: 190713856 10:43:38 INFO - PROCESS | 25332 | 10:43:41 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53698/tests/kraken/driver.html?testName=imaging-darkroom) 10:43:41 INFO - PROCESS | 25332 | RSS: Main: 225513472 10:43:41 INFO - PROCESS | 25332 | 10:43:45 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53698/tests/kraken/driver.html?testName=imaging-desaturate) 10:43:45 INFO - PROCESS | 25332 | RSS: Main: 226258944 10:43:45 INFO - PROCESS | 25332 | 10:43:48 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53698/tests/kraken/driver.html?testName=json-parse-financial) 10:43:49 INFO - PROCESS | 25332 | RSS: Main: 226107392 10:43:49 INFO - PROCESS | 25332 | 10:43:50 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:43:51 INFO - PROCESS | 25332 | RSS: Main: 188342272 10:43:51 INFO - PROCESS | 25332 | 10:43:53 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:43:53 INFO - PROCESS | 25332 | RSS: Main: 195870720 10:43:53 INFO - PROCESS | 25332 | 10:43:55 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:43:56 INFO - PROCESS | 25332 | RSS: Main: 192692224 10:43:56 INFO - PROCESS | 25332 | 10:43:58 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:43:59 INFO - PROCESS | 25332 | RSS: Main: 186691584 10:43:59 INFO - PROCESS | 25332 | 10:44:02 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:44:02 INFO - PROCESS | 25332 | RSS: Main: 191541248 10:44:02 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | Cycle 1(1): loaded http://localhost:53698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53698/tests/kraken/driver.html?testName=ai-astar) 10:44:04 INFO - PROCESS | 25332 | RSS: Main: 242429952 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | __start_tp_report 10:44:04 INFO - PROCESS | 25332 | _x_x_mozilla_page_load 10:44:04 INFO - PROCESS | 25332 | _x_x_mozilla_page_load_details 10:44:04 INFO - PROCESS | 25332 | |i|pagename|runs| 10:44:04 INFO - PROCESS | 25332 | |0;ai-astar;104;112;114;112;107;112;112;112;114;111 10:44:04 INFO - PROCESS | 25332 | |1;audio-beat-detection;152;116;118;169;118;121;150;121;152;122 10:44:04 INFO - PROCESS | 25332 | |2;audio-dft;160;161;160;158;160;167;162;161;160;161 10:44:04 INFO - PROCESS | 25332 | |3;audio-fft;74;76;75;111;78;75;77;75;105;74 10:44:04 INFO - PROCESS | 25332 | |4;audio-oscillator;85;84;129;85;85;84;113;84;85;135 10:44:04 INFO - PROCESS | 25332 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 10:44:04 INFO - PROCESS | 25332 | |6;imaging-darkroom;145;146;147;145;145;146;146;145;146;146 10:44:04 INFO - PROCESS | 25332 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;94 10:44:04 INFO - PROCESS | 25332 | |8;json-parse-financial;58;49;52;50;50;53;50;50;52;50 10:44:04 INFO - PROCESS | 25332 | |9;json-stringify-tinderbox;62;62;62;61;61;61;61;61;62;62 10:44:04 INFO - PROCESS | 25332 | |10;stanford-crypto-aes;80;93;78;78;79;78;77;80;77;77 10:44:04 INFO - PROCESS | 25332 | |11;stanford-crypto-ccm;136;134;124;124;132;123;124;127;155;123 10:44:04 INFO - PROCESS | 25332 | |12;stanford-crypto-pbkdf2;165;162;162;166;167;161;163;164;163;162 10:44:04 INFO - PROCESS | 25332 | |13;stanford-crypto-sha256-iterative;64;64;68;68;64;67;63;64;63;64 10:44:04 INFO - PROCESS | 25332 | __end_tp_report 10:44:04 INFO - PROCESS | 25332 | __start_cc_report 10:44:04 INFO - PROCESS | 25332 | _x_x_mozilla_cycle_collect,1669 10:44:04 INFO - PROCESS | 25332 | __end_cc_report 10:44:04 INFO - PROCESS | 25332 | __startTimestamp1471110244858__endTimestamp 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | ------- Summary: start ------- 10:44:04 INFO - PROCESS | 25332 | Number of tests: 14 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:2.05 10:44:04 INFO - PROCESS | 25332 | Values: 104.0 112.0 114.0 112.0 107.0 112.0 112.0 112.0 114.0 111.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:136.00 stddev:19.57 (14.4%) stddev-sans-first:19.63 10:44:04 INFO - PROCESS | 25332 | Values: 152.0 116.0 118.0 169.0 118.0 121.0 150.0 121.0 152.0 122.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:2.36 (1.5%) stddev-sans-first:2.47 10:44:04 INFO - PROCESS | 25332 | Values: 160.0 161.0 160.0 158.0 160.0 167.0 162.0 161.0 160.0 161.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:13.83 (18.4%) stddev-sans-first:14.37 10:44:04 INFO - PROCESS | 25332 | Values: 74.0 76.0 75.0 111.0 78.0 75.0 77.0 75.0 105.0 74.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.50 stddev:20.57 (24.3%) stddev-sans-first:21.36 10:44:04 INFO - PROCESS | 25332 | Values: 85.0 84.0 129.0 85.0 85.0 84.0 113.0 84.0 85.0 135.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:44:04 INFO - PROCESS | 25332 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 10:44:04 INFO - PROCESS | 25332 | Values: 145.0 146.0 147.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:44:04 INFO - PROCESS | 25332 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:2.63 (5.2%) stddev-sans-first:1.32 10:44:04 INFO - PROCESS | 25332 | Values: 58.0 49.0 52.0 50.0 50.0 53.0 50.0 50.0 52.0 50.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 10:44:04 INFO - PROCESS | 25332 | Values: 62.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:78.50 stddev:4.81 (6.1%) stddev-sans-first:5.10 10:44:04 INFO - PROCESS | 25332 | Values: 80.0 93.0 78.0 78.0 79.0 78.0 77.0 80.0 77.0 77.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:129.50 stddev:9.98 (7.7%) stddev-sans-first:10.36 10:44:04 INFO - PROCESS | 25332 | Values: 136.0 134.0 124.0 124.0 132.0 123.0 124.0 127.0 155.0 123.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.50 stddev:1.96 (1.2%) stddev-sans-first:2.00 10:44:04 INFO - PROCESS | 25332 | Values: 165.0 162.0 162.0 166.0 167.0 161.0 163.0 164.0 163.0 162.0 10:44:04 INFO - PROCESS | 25332 | 10:44:04 INFO - PROCESS | 25332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:2.06 10:44:04 INFO - PROCESS | 25332 | Values: 64.0 64.0 68.0 68.0 64.0 67.0 63.0 64.0 63.0 64.0 10:44:04 INFO - PROCESS | 25332 | -------- Summary: end -------- 10:44:04 INFO - PROCESS | 25332 | 10:44:05 INFO - TEST-INFO | 25332: exit 0 10:44:05 INFO - TEST-OK | kraken | took 61183ms 10:44:05 INFO - SUITE-END | took 1177s 10:44:06 INFO - Completed test suite (00:19:37) 10:44:06 INFO - javascript benchmark 10:44:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.377337645783, 3054.6639869614323, 3075.7078077582623, 3084.8766049358014, 3089.2122508760262, 5120.257562653423, 5234.241035049916, 5336.893262134759, 5415.214793854893, 5444.999999999995, 5346.492083252085, 5350.732463376835, 5374.7850085996515, 5410.1073322901675, 5439.401665816757, 4806.927896081553, 4821.204501257288, 4912.828051018215, 4921.409430868301, 5017.52333528316, 4936.35827342445, 4973.925391119136, 4978.900421991558, 4987.476314986929, 4992.525710057539, 4666.020135771492, 4772.973810630697, 4797.52024797521, 4830.686005409637, 4911.361523002005, 4800.039992001613, 4844.878878028042, 4846.079244943449, 4912.287718280829, 4956.08312462192, 4894.36373271476, 4900.995295964319, 4901.044296362211, 4905.0, 4939.481354457766, 5161.870953226162, 5293.655912365684, 5350.0904846176245, 5355.169948657965, 5400.351957765093, 5783.479486846204, 5801.071828507418, 5822.068469044975, 5826.242588463515, 5827.708614569255, 5513.751881165357, 5833.7374818133285, 5837.678927658977, 5870.677112758796, 5873.2658417697785, 5331.893362132736, 5373.59698022646, 5377.381601115882, 5382.111951527954, 5435.211894275308, 5952.0, 5955.880882382415, 5962.761489540457, 5964.7315870785915, 5965.105234214816, 5412.025835349675, 5723.0, 5723.742431590588, 5729.770809167587, 5730.455606717355, 5694.117411801178, 5730.942690573041, 5735.971320143372, 5781.161731548902, 5832.88334233313, 5720.399358067426, 5766.163906233573, 5766.855828604234, 5773.480386765127, 5775.047117225695, 5534.059209934321, 5735.8566035849435, 5761.337446193657, 5794.739236734357, 5801.88396232073, 4320.4383430153875, 4385.0, 4396.054848207651, 4406.405135306757, 4417.536158703354, 3927.9018024549614, 3933.547642021147, 3949.6840252779707, 3966.0283230608684, 3969.1466334737593, 5214.374275086938, 5510.201020851954, 5514.228008078872, 5524.116141417354, 5524.226608274845, 5719.256496655408, 5789.45000224978, 5789.986752318412, 5818.0, 5867.70661466925, 5384.461553844584, 5484.670919744828, 5487.0, 5488.890222195534, 5496.422875598085, 4747.454042785055, 5017.523335283142, 5032.119379108714, 5046.6719663221775, 5091.618128640367, 5955.702214889325, 5981.581289309794, 5984.431479009487, 6033.155358249761, 6077.544184186116, 5794.188813566188, 5817.418258174149, 5826.009578371772, 5826.912596310974, 5838.357780644211, 5687.77248910039, 5963.522918166623, 6018.789342372996, 6041.154238406539, 6043.456088952015, 5541.3904470507405, 5550.4449555044175, 5562.610617256915, 5620.241267428844, 5643.435656434323, 5664.631798933056, 5693.1460280956535, 5703.857403564944, 5714.399988001366, 5716.085426331933, 5422.267993820784, 5595.132754423071, 5599.04816181242, 5602.635828671123, 5606.495415412469, 5520.91718624229, 5542.362628297636, 5554.972225138848, 5602.747876345493, 5632.943670563406, 5574.749136288796, 5581.6371935824045, 5585.972070139624, 5587.944120558905, 5591.692456914746, 5384.407715151252, 5629.043062679272, 5677.034904066401, 5682.318121825242, 5685.914711279252, 5192.688438693691, 5469.988052210354, 5481.260029896072, 5488.5334746545395, 5573.554115670818], "value": 5298.483340446995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.843568018795, 597.1908064572505, 599.0804115682429, 614.6631077406639, 628.3308276685328, 32226.83886580567, 42823.57176428235, 43339.34990975134, 43595.0, 43771.56228437715, 40630.59369406305, 43843.0, 44177.0, 44286.55713442864, 44355.0, 7971.481853679521, 8764.56177191141, 8902.866457003118, 8933.196012358887, 10538.525766340534, 10445.895541044569, 10825.242233043651, 10840.078593319577, 10842.837357439645, 10855.782884342349, 10872.891271087306, 10929.0, 10944.835827462555, 10960.342379457257, 10960.890391096107, 10820.404877731722, 10864.076553492883, 10870.728231794228, 10879.782404351949, 10883.346999179996, 10680.572777088908, 10723.731906702316, 10744.623938162127, 10746.946265268702, 10752.946235268852, 41543.545975891, 41947.37078943818, 41965.16069678589, 41979.7901010493, 42075.0, 3193.616765988096, 3529.6470352964498, 3542.6103128655827, 3550.1302180965827, 3732.9920921351354, 30017.249568760955, 30195.547066793795, 30708.692913070805, 31540.36919261602, 34960.10558521809, 4221.472315960505, 4235.703500754948, 4246.108317253381, 4340.717853339523, 4365.192439398721, 349279.0, 351332.0, 355403.0, 355934.0, 357487.0, 57115.71442142763, 57437.0, 57476.13785793216, 57539.42460575424, 57559.0, 59922.0, 60042.0, 60250.69874650687, 60306.698466508264, 60370.09444858331, 16683.416080437128, 17120.14399280031, 17200.82799171992, 17214.65570688579, 17307.30770769155, 13316.0, 13349.199048057148, 13358.265295408652, 13382.0, 13400.32998350098, 15897.761533577006, 16092.436764713413, 16196.109213993344, 16229.756553651705, 16269.918650406673, 5661.830145095653, 5799.8250656004, 5821.621594596338, 5833.416658334218, 5854.356020837705, 947.7062110745691, 1008.7881544875659, 1070.5450183671908, 1095.4686976816238, 1128.08061429936, 32348.83825580857, 32488.350232995206, 32576.511352329733, 32965.61703983403, 32974.67025329764, 818.5620692929373, 1080.0927221134284, 1096.9561217551368, 1129.678041758095, 1201.381288636353, 17067.658646826992, 17503.64992700139, 17558.29766809339, 17579.472615821545, 17607.647847042987, 499008.0, 504729.57433831133, 506267.0, 507134.0, 507140.0, 57844.421555783905, 57987.71006144942, 58037.12944305839, 58077.12884306739, 58101.70949145312, 1338.5382043195082, 1352.8444228913604, 1398.161103337989, 1399.4751968011994, 1406.5077222972081, 30850.69149308568, 32253.677463225067, 32551.0, 33268.66731332656, 33322.83338583291, 56970.0, 57213.14180287216, 57310.0, 57370.713146434, 57682.134767979354, 422852.0, 426056.0, 426234.0, 426271.0, 426688.0, 25233.495330092926, 27811.860940695977, 28132.85933570319, 28204.85897570499, 28576.42847143087, 48648.75675621599, 49112.263316051, 50034.249486258464, 50043.74978125086, 50504.49495505145, 39841.40237896492, 41286.58713412828, 42048.0, 42805.57194428016, 43690.0, 40200.195996080496, 41061.0, 41085.0, 41662.58337416587, 42107.57892421159, 42030.36954445625, 42229.0, 42525.78737106295, 42713.1457370857, 42888.0, 33986.83006584951, 36323.45514817227, 37538.436923446716, 38446.615533844306, 38751.0, 28101.0, 28690.56964145581, 28709.71290287154, 28850.0, 28920.276993075342], "value": 20441.709927060027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4237914318095, 395.96238357356043, 412.60183922514767, 414.5315793153736, 429.56828387470586, 15607.843921560796, 19425.028748562585, 19628.705569416452, 19852.60294794105, 21156.365309040753, 19840.0, 20066.49833754157, 20157.899210503965, 20343.79656203441, 20603.1758729651, 5636.887262254762, 5691.886162276752, 5774.249347584808, 5781.768729250825, 5824.825255242349, 4218.198542276973, 5669.8299051028325, 5757.856053598652, 5759.942400575983, 5759.942400576004, 5996.940030599681, 6226.190595222637, 6261.655608941506, 6379.904301435482, 6390.146857411345, 6151.138840562303, 6340.936590634081, 6359.618422894618, 6377.107204991305, 6430.614163150226, 5623.903338848926, 5652.547796176337, 5661.688607126606, 5712.514436272922, 5714.485696287354, 23925.64111538328, 24508.509829803304, 24575.13987010464, 24750.381240468952, 24929.750702492925, 2350.9999999999827, 2372.0511795281855, 2436.7319594844553, 2472.208893154191, 2543.5421624107653, 14487.203203823785, 14949.177795221258, 15147.54557363281, 15210.847891521054, 15901.1254381009, 1859.2470049629922, 1947.123794292574, 1958.8726732762325, 1982.900854957261, 1995.2712072388533, 79931.20068799295, 80608.0, 81378.0, 81698.59150704209, 83089.58455207746, 10733.892661073289, 10832.729181770519, 10999.61501347449, 11084.646481723621, 11212.719682008015, 15471.071735695668, 15508.0, 15510.302036408162, 15512.379504819906, 15555.84444155544, 8216.26053655174, 8400.495970241805, 8431.28334091609, 8662.783430414163, 8681.262092722063, 8046.235607617267, 8175.959120204361, 8208.384371172186, 8331.291840193651, 8393.118722534167, 6759.121314229119, 6795.1845778506895, 6817.386435220854, 6893.0, 6912.306484911129, 1954.990225048894, 1958.6866101423705, 1958.9118489667999, 2023.605396947581, 2030.5634288628016, 1003.4932359158578, 1003.6286573967678, 1034.4517405774952, 1042.5100202904623, 1093.2456604942565, 19954.70067948982, 21113.68329475059, 21224.469388265108, 21228.893855530623, 21308.36074917755, 1007.3351587951917, 1022.9744256393501, 1025.7999690060515, 1039.3555995282973, 1056.0970370333407, 9154.954225228832, 11090.667279981613, 11853.288802671867, 12095.21381110225, 12123.33321667299, 478854.0, 514350.0, 518242.0, 519834.0, 523156.0, 81867.5906620475, 82886.0, 84192.57903710443, 85839.0, 85842.0, 1028.2596530498029, 1037.3464717228098, 1040.9375437473625, 1051.9631812886512, 1059.1685526861377, 17738.0, 17759.467215983543, 17771.289148433916, 18938.715919260947, 19375.0, 40001.399978999754, 43635.34546981861, 43901.78049109734, 44211.33682994694, 44426.55573444354, 55084.44915550954, 57447.0, 57944.0, 59530.70234648799, 59581.40418595932, 8337.833243334979, 8369.49783013021, 8638.524881131598, 11752.177347585586, 11883.0, 12101.576444824388, 12860.485580576673, 13381.130226535244, 13739.0, 13749.106308089942, 11641.359725214856, 11849.940750296539, 11868.169228154291, 12193.634190974284, 12345.197562158432, 11648.068154547447, 11956.461959211681, 11964.702443181772, 11990.220635658654, 12301.75396492083, 12065.517379304729, 12378.133530652767, 12514.74970500603, 12526.812097818722, 12616.49534018629, 12075.154739168174, 12284.570040048555, 12287.1399002069, 12434.197041429123, 12605.87394126047, 12020.939895300467, 12038.976686981705, 12149.817752733892, 12278.201916875374, 12448.128630996105], "value": 9786.172497198808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.0806231606718, 1447.9710405791884, 1491.2171110167164, 1576.2591581956476, 1717.261577521666, 7984.441089123764, 8215.83568328633, 8277.42058055937, 8412.789680257996, 8463.66145354185, 8322.83354332913, 8399.244068033875, 8401.83196336073, 8414.116517765638, 8424.620892059856, 2381.8809059546998, 2417.3231495181376, 2421.5762241607736, 2424.018272599591, 2426.7815896569305, 2383.7377888432347, 2390.306811024801, 2454.6808914841044, 2459.6802415685934, 2462.5936720441105, 2398.0887262840097, 2407.5064611754547, 2410.5419970205694, 2438.1100898172217, 2447.449323902126, 2351.929442116739, 2357.9764202358015, 2363.2319496163814, 2366.7278262999716, 2406.2540612410207, 2307.4462129088897, 2321.9071237150492, 2321.918732844359, 2325.081592770846, 2329.138218859016, 8348.457350272212, 8356.540390278533, 8396.118407567179, 8407.45351552147, 8489.61796719149, 5313.468653134694, 5519.116941289374, 5519.144532597454, 5521.420250873641, 5530.640508366983, 3465.549478567795, 3467.514547963287, 3528.1708798432346, 3537.964620353789, 3569.3575156471825, 1120.9327440353604, 1126.3129491010477, 1133.1274918312936, 1148.0585919545977, 1156.4853640130145, 11427.48576314068, 11451.770964580744, 11493.827592586034, 11504.02215811657, 11550.191486595942, 4448.799804008828, 4592.425946756655, 4697.412823397075, 4750.8337208197545, 4765.0, 9100.635974561075, 9174.587143578556, 9183.265338772882, 9187.035361287102, 9193.448393096436, 5281.973590132102, 5314.946850531523, 5316.548093412103, 5316.973415132977, 5318.0, 4196.139791342828, 4854.17479028566, 4928.408590969107, 4999.375078115236, 5043.344365232496, 3705.814709264526, 3822.866199682998, 3898.590647981978, 3921.627445392683, 3969.126792105732, 1191.8450601421932, 1213.3266037349356, 1215.8784121587948, 1230.5323976888726, 1233.6730766346925, 977.5552123783662, 997.8952210017989, 1000.7298029531986, 1023.6110278094277, 1033.1476531861244, 6088.543359247986, 6113.877722445526, 6147.815565533041, 6158.261008678987, 6310.905336419957, 490.1422510606439, 491.8991606720614, 507.47983317100267, 513.7611010879884, 514.6028532534114, 4205.074883525619, 4207.431996680471, 4283.978580107079, 4353.7170083945075, 4368.650507959355, 10128.189744820396, 10394.740131496774, 10626.0, 10721.678349649523, 11034.117270618332, 10806.675799725863, 10815.459227038617, 10831.0, 10838.566457341618, 10843.240973131962, 7788.221177882167, 8282.4202305838, 8330.916690833013, 8356.331493480508, 8363.540005299767, 5981.880362392641, 6043.36544662804, 6108.175396321618, 6174.073888916699, 6316.526260530387, 9545.713628591153, 9744.025597440483, 9747.707568772948, 9870.161036311994, 9895.25785566071, 9947.502624868872, 9970.601175952881, 10018.899811001796, 10030.699079027641, 10038.749031274276, 6570.310117437792, 6739.966300168468, 6754.425873800586, 7758.844823103619, 7836.412269079956, 7347.7795666130105, 8114.269715725613, 8409.87385189235, 8418.494890306602, 8499.447535910145, 7647.541147530944, 7674.4533545848035, 7820.217978202134, 7906.841863162819, 7939.563324017235, 7470.8505829882015, 7588.734394296173, 7604.429667774828, 7671.3862890967475, 7826.530408175528, 7063.752768653072, 7109.893351599833, 7127.607981561064, 7130.786076417716, 7166.140063192451, 5182.300389447527, 5225.294585230945, 5259.526642602184, 5264.578833693372, 5479.6164268500825, 4977.751112444291, 5022.547970682656, 5069.645124841226, 5168.767405466839, 5261.421243663118], "value": 4537.96143770606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8040463900784, 314.8520195508111, 321.8246055899535, 322.46953761063065, 326.225215114104, 5057.418396884359, 5096.572959571326, 5283.603729720272, 5327.786888524459, 5362.954223926341, 5097.286379906816, 5185.351831021122, 5224.399194092681, 5282.07563676357, 5291.259223708684, 4147.440095587087, 4156.833726650931, 4163.3130533461945, 4189.937150942746, 4202.453681021463, 4041.555428902818, 4116.464859568252, 4120.649744771698, 4149.315362965107, 4167.645515207554, 4085.1829634073156, 4091.509018917734, 4096.97951510242, 4107.158032603309, 4130.896727581804, 4087.305158123111, 4102.774347410891, 4107.835686572518, 4120.423140760296, 4122.134351786129, 3664.3221004114325, 3688.61269566697, 3696.8890933272046, 3700.611435799256, 3726.6273372662517, 4926.4088309403105, 5082.923756143661, 5104.285400043997, 5109.182530795092, 5143.254228136937, 4685.554872287127, 4720.858374248778, 4728.361671174382, 4736.336912832172, 4736.9526304736855, 5378.300820893259, 5489.670619762787, 5490.203920431555, 5494.862628434321, 5517.5585953123655, 3955.6155345629086, 4015.6586690131376, 4019.075612609087, 4025.496812898388, 4044.7573145611063, 5670.0, 5680.488756011938, 5685.40303268155, 5689.0, 5700.686462244575, 4135.29699951009, 4142.855000075043, 4145.751254924654, 4151.626353628188, 4166.0, 3871.825767840454, 4035.8991025224605, 4036.1725846201457, 4052.7163098583405, 4209.642180414699, 4640.559146881041, 4644.187267228222, 4656.906861862743, 4663.440387153563, 4667.649926255544, 5498.147787093007, 5538.556915446755, 5551.611387202938, 5590.273264475592, 5635.859103522363, 1300.1873828856965, 1321.2270821569298, 1337.3112846883862, 1348.9797653035212, 1361.1152750712117, 926.7266156483853, 937.2642475656713, 960.6637676813059, 968.5157421289356, 973.9805203895883, 5284.841454756363, 5293.232481290192, 5295.682259064469, 5305.734713264322, 5336.252924590561, 5582.162675598693, 5610.1584762285165, 5620.91568626471, 5637.774489020475, 5644.604877658525, 5176.197689358156, 5225.634205605647, 5260.210968354778, 5332.146856502941, 5333.7066461345, 2611.164427383257, 2616.306678730138, 2623.921282361532, 2625.698044724843, 2648.708642049373, 5085.593152547787, 5086.898262034739, 5091.389033315952, 5125.846224613268, 5127.53852153308, 5008.148614735431, 5046.722430266371, 5407.378151512547, 5772.612814261108, 5830.970845145832, 5896.970515147397, 5919.792807251725, 5920.881582368328, 5923.348431672513, 5953.76184952597, 5501.001953935035, 5659.387074683696, 5710.743016564182, 5754.223179870832, 5771.480566749013, 5646.802361917313, 5658.0, 5664.572933375413, 5671.773129074956, 5680.857978550569, 5881.088431293157, 5896.233489646319, 5903.527717782653, 5920.79277225295, 6001.849953751192, 3865.96134038656, 4048.2308361411237, 4064.349704047338, 4074.5925407459017, 4083.8570650027104, 5402.837914862561, 5681.0, 5683.829485115453, 5694.629849059798, 5726.141078838207, 5451.236826844166, 5578.0, 5581.441855814386, 5603.607747457639, 5623.550115990629, 5541.5289700375915, 5564.55483561306, 5578.609497335147, 5622.2128901954575, 5637.3235211774845, 5284.841454756363, 5541.418151094238, 5542.2795036644975, 5556.444355564411, 5575.177471487215, 5604.915926261027, 5607.635503692247, 5632.098864181711, 5641.492265696107, 5649.85875353103, 5487.4238204987905, 5509.972450137724, 5530.557555395479, 5547.639403438763, 5560.220729366564], "value": 4183.932788616067, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.4170992610506, 829.4898637338039, 844.0968164064453, 872.7905302727347, 874.3879284500849, 14645.0, 17742.290308387648, 17743.467695969142, 17745.20146593403, 17748.822511774877, 15880.920595397036, 15988.840111598909, 16002.5999350016, 16008.759868601981, 16013.35946562136, 824.3775949158392, 848.2281124177, 849.8300339932007, 850.8766228896807, 851.1786126388034, 812.6789917982394, 814.3851392198882, 814.5927036481759, 814.8533264012505, 815.0097631377874, 703.9788806335819, 848.4654667559429, 861.5390765940223, 871.6861929705301, 872.7381785464368, 874.623911717961, 874.8294082653916, 874.9650013999433, 875.1423604867202, 875.4790899414838, 629.298332359416, 636.2810024672091, 637.665225756477, 637.7289651897971, 638.0078977190467, 12201.694957626041, 15121.697566048728, 15663.21683915811, 15753.842461575352, 16146.273417696231, 14615.0, 14854.554363369009, 15329.616759580987, 15539.14534700591, 15697.215139242991, 12864.09951303409, 12911.612651620373, 13198.60404187876, 13255.668608284774, 13660.316984150753, 3902.1610353774076, 3974.225026119908, 3987.7208595398333, 4038.9798051009557, 4123.8556650517085, 83914.58042709748, 85941.57029214814, 87082.0, 88429.55785221097, 88451.55774221088, 11598.0, 11608.709782255342, 11712.941435292769, 11745.47145378443, 12205.20666156697, 24257.055355486336, 24508.38729031753, 24517.63223551648, 24532.0, 24559.38601534976, 8549.187827156535, 8804.075572064969, 9000.36997410188, 9153.0, 9161.45031298111, 4994.875128121754, 5006.4743201964, 5105.591552675777, 5183.170692689152, 5344.732763361816, 3703.7222208334483, 3818.9045273868373, 3836.0985168485386, 3849.3263678856088, 3850.403187505941, 574.3165632896839, 589.1957478042527, 593.5103539579864, 600.0489224579004, 600.9128676341993, 613.5459759777822, 622.6077571130159, 633.597665482422, 636.6721138613618, 709.3332267668375, 9692.854607180898, 9937.602495900082, 9989.400635961865, 10396.896031039743, 10753.569857205624, 670.6747227594612, 689.6620655878684, 732.6263605561202, 734.9853002939911, 744.7356188553094, 4722.5513576210205, 5019.698818070928, 5099.082165210298, 5099.8725031873755, 5133.563647089964, 96706.0, 98772.0, 126052.0, 134274.0, 134806.0, 97055.51472242735, 100366.0, 100369.49815250876, 100952.0, 101239.0, 85165.0, 88101.5594922034, 88239.0, 89837.20325593321, 90799.99999999868, 10041.698749037541, 10120.94939525327, 10241.23190760681, 10286.125679317342, 10361.84457233127, 34716.826415867756, 35564.28871422609, 49447.25829112638, 49756.0, 50635.24047139222, 50435.0, 62589.61872668869, 66634.66682666556, 68348.44501314455, 72490.63754681403, 13146.80279795823, 13229.564278889266, 13470.393832277376, 13484.32578371058, 13992.930035349758, 15739.213039348217, 15820.762688559911, 15969.520914372588, 16070.35718571244, 16144.838551614333, 14466.421343146156, 14830.925845370704, 14881.330340134937, 14986.47547335838, 15014.699706006037, 14166.858331416553, 14562.635934101732, 14865.108093514424, 15019.474318398803, 15045.699086018438, 14242.857571424152, 14554.85445145535, 14614.269286535844, 15092.924535377253, 15108.622284442978, 11250.762416134055, 11840.28958262507, 11967.401629918644, 11976.28142311464, 12718.809217861924, 11865.347405892759, 12598.811017834923, 12690.302033388252, 12838.614841554769, 12897.226166430044], "value": 7854.951528147546, "unit": "score"}], "name": "dromaeo_css", "value": 7353.370459206138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 112.0, 107.0, 112.0, 112.0, 112.0, 114.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 118.0, 169.0, 118.0, 121.0, 150.0, 121.0, 152.0, 122.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 158.0, 160.0, 167.0, 162.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 111.0, 78.0, 75.0, 77.0, 75.0, 105.0, 74.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 129.0, 85.0, 85.0, 84.0, 113.0, 84.0, 85.0, 135.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 49.0, 52.0, 50.0, 50.0, 53.0, 50.0, 50.0, 52.0, 50.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 93.0, 78.0, 78.0, 79.0, 78.0, 77.0, 80.0, 77.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 124.0, 124.0, 132.0, 123.0, 124.0, 127.0, 155.0, 123.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 166.0, 167.0, 161.0, 163.0, 164.0, 163.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 68.0, 64.0, 67.0, 63.0, 64.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1493.6, "alertThreshold": 2.0}]} 10:44:06 INFO - Return code: 0 10:44:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:44:06 INFO - # TBPL SUCCESS # 10:44:06 INFO - Running post-action listener: _resource_record_post_action 10:44:06 INFO - [mozharness: 2016-08-13 17:44:06.147566Z] Finished run-tests step (success) 10:44:06 INFO - Running post-run listener: _resource_record_post_run 10:44:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406855680; Read time: 16; Write time: 249848 10:44:06 INFO - TinderboxPrint: CPU usage
13.0% 10:44:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:44:06 INFO - TinderboxPrint: I/O write bytes / time
406,855,680 / 249,848 10:44:06 INFO - TinderboxPrint: CPU idle
8,288.9 (87.0%) 10:44:06 INFO - TinderboxPrint: CPU user
1,196.4 (12.6%) 10:44:06 INFO - TinderboxPrint: Swap in / out
0 / 0 10:44:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117268480; Read time: 0; Write time: 62896 10:44:06 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288948224; Read time: 0; Write time: 186880 10:44:06 INFO - Running post-run listener: _upload_blobber_files 10:44:06 INFO - Blob upload gear active. 10:44:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:44:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:44:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:07 INFO - (blobuploader) - INFO - Done attempting. 10:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:11 INFO - (blobuploader) - INFO - Done attempting. 10:44:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:44:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:12 INFO - (blobuploader) - INFO - Done attempting. 10:44:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:44:12 INFO - Return code: 0 10:44:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:44:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:44:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545b16d164168646811ec6879020e9324a480d46da09f16f3c66753e5c48aba74a33a753d278e2850a80bb5462d814a3e279ac751e45d7ec4b0b18c46d4ff581", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f05bca4445a8cd8abae99874487ae3ad174c6d133e2e56fab9dee5111f36440ba0135138e2f5afce4430233953fda7010b92b4856c259464beaaa2d832124258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb6f87a1b7cb067f080f07a254189c1bde46ce456366f99a8a8ce137afd9208240151561cdd0c6587f6551303c5b51621b61d2f7e545bdad81798bd50530262e"} 10:44:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:44:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:44:12 INFO - Contents: 10:44:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545b16d164168646811ec6879020e9324a480d46da09f16f3c66753e5c48aba74a33a753d278e2850a80bb5462d814a3e279ac751e45d7ec4b0b18c46d4ff581", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f05bca4445a8cd8abae99874487ae3ad174c6d133e2e56fab9dee5111f36440ba0135138e2f5afce4430233953fda7010b92b4856c259464beaaa2d832124258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb6f87a1b7cb067f080f07a254189c1bde46ce456366f99a8a8ce137afd9208240151561cdd0c6587f6551303c5b51621b61d2f7e545bdad81798bd50530262e"} 10:44:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:44:12 INFO - Copying logs to upload dir... 10:44:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:44:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.216882 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-13 10:44:11.322107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 10:44:11.325914) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545b16d164168646811ec6879020e9324a480d46da09f16f3c66753e5c48aba74a33a753d278e2850a80bb5462d814a3e279ac751e45d7ec4b0b18c46d4ff581", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f05bca4445a8cd8abae99874487ae3ad174c6d133e2e56fab9dee5111f36440ba0135138e2f5afce4430233953fda7010b92b4856c259464beaaa2d832124258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb6f87a1b7cb067f080f07a254189c1bde46ce456366f99a8a8ce137afd9208240151561cdd0c6587f6551303c5b51621b61d2f7e545bdad81798bd50530262e"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471098665/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545b16d164168646811ec6879020e9324a480d46da09f16f3c66753e5c48aba74a33a753d278e2850a80bb5462d814a3e279ac751e45d7ec4b0b18c46d4ff581", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f05bca4445a8cd8abae99874487ae3ad174c6d133e2e56fab9dee5111f36440ba0135138e2f5afce4430233953fda7010b92b4856c259464beaaa2d832124258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cb6f87a1b7cb067f080f07a254189c1bde46ce456366f99a8a8ce137afd9208240151561cdd0c6587f6551303c5b51621b61d2f7e545bdad81798bd50530262e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 10:44:11.351783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:44:11.352091) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1471097862.103824-1817121779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 10:44:11.435481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 10:44:11.435820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 10:44:11.436144) ========= ========= Total master_lag: 0.16 =========