builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1471622025.96 results: success (0) buildid: 20160819065423 builduid: fe9263ec600b46f692fa243ba6cee6fb revision: 74f332c38a6983707dd1f66d132baf45750d9c86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:45.959395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:45.959798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:45.960134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.020552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.020840) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 08:53:46-- 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% 17.4M=0.001s 2016-08-19 08:53:46 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.159098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.159382) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014637 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.211630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.212152) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 74f332c38a6983707dd1f66d132baf45750d9c86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 74f332c38a6983707dd1f66d132baf45750d9c86 --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=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 08:53:46,710 truncating revision to first 12 chars 2016-08-19 08:53:46,710 Setting DEBUG logging. 2016-08-19 08:53:46,710 attempt 1/10 2016-08-19 08:53:46,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/74f332c38a69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:53:47,008 unpacking tar archive at: mozilla-central-74f332c38a69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630881 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.861576) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.861873) ========= script_repo_revision: 74f332c38a6983707dd1f66d132baf45750d9c86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.862243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.862524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:53:46.873020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-19 08:53:46.873339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:47 INFO - MultiFileLogger online at 20160819 08:53:47 in /builds/slave/test 08:53:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:53:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:47 INFO - {'append_to_log': False, 08:53:47 INFO - 'base_work_dir': '/builds/slave/test', 08:53:47 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:53:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:47 INFO - 'branch': 'Firefox-Non-PGO', 08:53:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:47 INFO - 'config_files': ('talos/linux_config.py',), 08:53:47 INFO - 'default_actions': ('clobber', 08:53:47 INFO - 'read-buildbot-config', 08:53:47 INFO - 'download-and-extract', 08:53:47 INFO - 'populate-webroot', 08:53:47 INFO - 'create-virtualenv', 08:53:47 INFO - 'install', 08:53:47 INFO - 'run-tests'), 08:53:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:47 INFO - 'download_minidump_stackwalk': True, 08:53:47 INFO - 'download_symbols': 'ondemand', 08:53:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:47 INFO - 'installer_path': 'installer.exe', 08:53:47 INFO - 'log_level': 'info', 08:53:47 INFO - 'log_name': 'talos', 08:53:47 INFO - 'log_to_console': True, 08:53:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:47 INFO - 'opt_config_files': (), 08:53:47 INFO - 'pip_index': False, 08:53:47 INFO - 'sps_profile': False, 08:53:47 INFO - 'sps_profile_interval': 0, 08:53:47 INFO - 'suite': 'dromaeojs', 08:53:47 INFO - 'system_bits': '32', 08:53:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:47 INFO - 'title': 'talos-linux64-ix-037', 08:53:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:47 INFO - 'use_talos_json': True, 08:53:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:47 INFO - 'work_dir': 'build'} 08:53:47 INFO - [mozharness: 2016-08-19 15:53:47.463211Z] Running clobber step. 08:53:47 INFO - Running pre-action listener: _resource_record_pre_action 08:53:47 INFO - Running main action method: clobber 08:53:47 INFO - rmtree: /builds/slave/test/build 08:53:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:47 INFO - Running post-action listener: _resource_record_post_action 08:53:47 INFO - [mozharness: 2016-08-19 15:53:47.920262Z] Finished clobber step (success) 08:53:47 INFO - [mozharness: 2016-08-19 15:53:47.920362Z] Running read-buildbot-config step. 08:53:47 INFO - Running pre-action listener: _resource_record_pre_action 08:53:47 INFO - Running main action method: read_buildbot_config 08:53:47 INFO - Using buildbot properties: 08:53:47 INFO - { 08:53:47 INFO - "project": "", 08:53:47 INFO - "product": "firefox", 08:53:47 INFO - "script_repo_revision": "production", 08:53:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:53:47 INFO - "repository": "", 08:53:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:53:47 INFO - "buildid": "20160819065423", 08:53:47 INFO - "pgo_build": "False", 08:53:47 INFO - "basedir": "/builds/slave/test", 08:53:47 INFO - "buildnumber": 183, 08:53:47 INFO - "slavename": "talos-linux64-ix-037", 08:53:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:53:47 INFO - "platform": "ubuntu64_hw", 08:53:47 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:53:47 INFO - "branch": "mozilla-central", 08:53:47 INFO - "repo_path": "mozilla-central", 08:53:47 INFO - "revision": "74f332c38a6983707dd1f66d132baf45750d9c86", 08:53:47 INFO - "stage_platform": "linux64", 08:53:47 INFO - "builduid": "fe9263ec600b46f692fa243ba6cee6fb", 08:53:47 INFO - "slavebuilddir": "test" 08:53:47 INFO - } 08:53:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:53:47 INFO - Running post-action listener: _resource_record_post_action 08:53:47 INFO - [mozharness: 2016-08-19 15:53:47.922799Z] Finished read-buildbot-config step (success) 08:53:47 INFO - [mozharness: 2016-08-19 15:53:47.922887Z] Running download-and-extract step. 08:53:47 INFO - Running pre-action listener: _resource_record_pre_action 08:53:47 INFO - Running main action method: download_and_extract 08:53:47 INFO - mkdir: /builds/slave/test/build/tests 08:53:47 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')]} 08:53:47 INFO - trying https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:53:48 INFO - Downloaded 1361 bytes. 08:53:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:53:48 INFO - Using the following test package requirements: 08:53:48 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:53:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'jsshell-linux-x86_64.zip'], 08:53:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:48 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53:48 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')]} 08:53:48 INFO - trying https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:49 INFO - Downloaded 20328323 bytes. 08:53:49 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 08:53:53 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 08:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:53 INFO - trying https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:54 INFO - Downloaded 20328323 bytes. 08:53:54 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 08:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:58 INFO - trying https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:58 INFO - Downloading https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:54:00 INFO - Downloaded 14413981 bytes. 08:54:00 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 08:54: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')]} 08:54:00 INFO - trying https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:54:00 INFO - Downloading https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:54:02 INFO - Downloaded 55772734 bytes. 08:54:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:54:02 INFO - mkdir: /builds/slave/test/properties 08:54:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:02 INFO - Contents: 08:54:02 INFO - build_url:https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:54:03 INFO - Running post-action listener: _resource_record_post_action 08:54:03 INFO - Running post-action listener: set_extra_try_arguments 08:54:03 INFO - [mozharness: 2016-08-19 15:54:03.123067Z] Finished download-and-extract step (success) 08:54:03 INFO - [mozharness: 2016-08-19 15:54:03.123293Z] Running populate-webroot step. 08:54:03 INFO - Running pre-action listener: _resource_record_pre_action 08:54:03 INFO - Running main action method: populate_webroot 08:54:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:03 INFO - '--tppagecycles', 08:54:03 INFO - '7'], 08:54:03 INFO - 'tests': ['tsvgm']}}, 08:54:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['damp', 'tps']}, 08:54:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'tests': ['damp', 'tps']}, 08:54:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['dromaeo_dom']}, 08:54:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['basic_compositor_video']}, 08:54:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['a11yr', 08:54:03 INFO - 'ts_paint', 08:54:03 INFO - 'tpaint', 08:54:03 INFO - 'sessionrestore', 08:54:03 INFO - 'sessionrestore_no_auto_restore', 08:54:03 INFO - 'tabpaint']}, 08:54:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['tsvgx', 08:54:03 INFO - 'tsvgr_opacity', 08:54:03 INFO - 'tart', 08:54:03 INFO - 'tscrollx', 08:54:03 INFO - 'cart']}, 08:54:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:03 INFO - 'tsvgr_opacity', 08:54:03 INFO - 'tart', 08:54:03 INFO - 'tscrollx', 08:54:03 INFO - 'cart']}, 08:54:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'talos_options': ['--disable-e10s'], 08:54:03 INFO - 'tests': ['tp5o']}, 08:54:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'tests': ['tp5o']}, 08:54:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'talos_options': ['--disable-e10s', 08:54:03 INFO - '--xperf_path', 08:54:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:03 INFO - 'tests': ['tp5n']}, 08:54:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:03 INFO - 'talos_options': ['--xperf_path', 08:54:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:03 INFO - 'tests': ['tp5n']}}, 08:54:03 INFO - 'talos.zip': {'path': '', 08:54:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:03 INFO - Running post-action listener: _resource_record_post_action 08:54:03 INFO - [mozharness: 2016-08-19 15:54:03.143176Z] Finished populate-webroot step (success) 08:54:03 INFO - [mozharness: 2016-08-19 15:54:03.143265Z] Running create-virtualenv step. 08:54:03 INFO - Running pre-action listener: _resource_record_pre_action 08:54:03 INFO - Running main action method: create_virtualenv 08:54:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:03 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 08:54:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:03 INFO - Using real prefix '/usr' 08:54:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:05 INFO - Installing pip.................done. 08:54:05 INFO - Return code: 0 08:54:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:54:05 INFO - Using env: {'DISPLAY': ':0', 08:54:05 INFO - 'HOME': '/home/cltbld', 08:54:05 INFO - 'LANG': 'en_US.UTF-8', 08:54:05 INFO - 'LANGUAGE': 'en_US:en', 08:54:05 INFO - 'LOGNAME': 'cltbld', 08:54:05 INFO - 'MAIL': '/var/mail/cltbld', 08:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:05 INFO - 'MOZ_NO_REMOTE': '1', 08:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:05 INFO - 'NO_EM_RESTART': '1', 08:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:05 INFO - 'PWD': '/builds/slave/test', 08:54:05 INFO - 'SHELL': '/bin/bash', 08:54:05 INFO - 'SHLVL': '1', 08:54:05 INFO - 'TERM': 'linux', 08:54:05 INFO - 'TMOUT': '86400', 08:54:05 INFO - 'USER': 'cltbld', 08:54:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:05 INFO - '_': '/tools/buildbot/bin/python'} 08:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:54:05 INFO - Cleaning up... 08:54:05 INFO - Return code: 0 08:54:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:54:05 INFO - Using env: {'DISPLAY': ':0', 08:54:05 INFO - 'HOME': '/home/cltbld', 08:54:05 INFO - 'LANG': 'en_US.UTF-8', 08:54:05 INFO - 'LANGUAGE': 'en_US:en', 08:54:05 INFO - 'LOGNAME': 'cltbld', 08:54:05 INFO - 'MAIL': '/var/mail/cltbld', 08:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:05 INFO - 'MOZ_NO_REMOTE': '1', 08:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:05 INFO - 'NO_EM_RESTART': '1', 08:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:05 INFO - 'PWD': '/builds/slave/test', 08:54:05 INFO - 'SHELL': '/bin/bash', 08:54:05 INFO - 'SHLVL': '1', 08:54:05 INFO - 'TERM': 'linux', 08:54:05 INFO - 'TMOUT': '86400', 08:54:05 INFO - 'USER': 'cltbld', 08:54:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:05 INFO - '_': '/tools/buildbot/bin/python'} 08:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:06 INFO - Downloading/unpacking psutil>=3.1.1 08:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:08 INFO - Installing collected packages: psutil 08:54:08 INFO - Running setup.py install for psutil 08:54:08 INFO - building 'psutil._psutil_linux' extension 08:54:08 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 08:54:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:54:08 INFO - building 'psutil._psutil_posix' extension 08:54:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:54:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:54:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:08 INFO - Successfully installed psutil 08:54:08 INFO - Cleaning up... 08:54:08 INFO - Return code: 0 08:54:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:08 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 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:08 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 08:54:08 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 08:54:08 INFO - Using env: {'DISPLAY': ':0', 08:54:08 INFO - 'HOME': '/home/cltbld', 08:54:08 INFO - 'LANG': 'en_US.UTF-8', 08:54:08 INFO - 'LANGUAGE': 'en_US:en', 08:54:08 INFO - 'LOGNAME': 'cltbld', 08:54:08 INFO - 'MAIL': '/var/mail/cltbld', 08:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:08 INFO - 'MOZ_NO_REMOTE': '1', 08:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:08 INFO - 'NO_EM_RESTART': '1', 08:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:08 INFO - 'PWD': '/builds/slave/test', 08:54:08 INFO - 'SHELL': '/bin/bash', 08:54:08 INFO - 'SHLVL': '1', 08:54:08 INFO - 'TERM': 'linux', 08:54:08 INFO - 'TMOUT': '86400', 08:54:08 INFO - 'USER': 'cltbld', 08:54:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:08 INFO - '_': '/tools/buildbot/bin/python'} 08:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:54:10 INFO - Installing collected packages: mozsystemmonitor 08:54:10 INFO - Running setup.py install for mozsystemmonitor 08:54:10 INFO - Successfully installed mozsystemmonitor 08:54:10 INFO - Cleaning up... 08:54:10 INFO - Return code: 0 08:54:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54: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==2.5.1'] in /builds/slave/test/build 08:54: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==2.5.1 08:54:10 INFO - Using env: {'DISPLAY': ':0', 08:54:10 INFO - 'HOME': '/home/cltbld', 08:54:10 INFO - 'LANG': 'en_US.UTF-8', 08:54:10 INFO - 'LANGUAGE': 'en_US:en', 08:54:10 INFO - 'LOGNAME': 'cltbld', 08:54:10 INFO - 'MAIL': '/var/mail/cltbld', 08:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:10 INFO - 'MOZ_NO_REMOTE': '1', 08:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:10 INFO - 'NO_EM_RESTART': '1', 08:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:10 INFO - 'PWD': '/builds/slave/test', 08:54:10 INFO - 'SHELL': '/bin/bash', 08:54:10 INFO - 'SHLVL': '1', 08:54:10 INFO - 'TERM': 'linux', 08:54:10 INFO - 'TMOUT': '86400', 08:54:10 INFO - 'USER': 'cltbld', 08:54:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:10 INFO - '_': '/tools/buildbot/bin/python'} 08:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:13 INFO - warning: no files found matching '*.txt' 08:54:13 INFO - no previously-included directories found matching 'build' 08:54:13 INFO - no previously-included directories found matching 'dist' 08:54:13 INFO - no previously-included directories found matching '.git*' 08:54:13 INFO - Installing collected packages: jsonschema, functools32 08:54:13 INFO - Running setup.py install for functools32 08:54:13 INFO - warning: no files found matching '*.txt' 08:54:13 INFO - no previously-included directories found matching 'build' 08:54:13 INFO - no previously-included directories found matching 'dist' 08:54:13 INFO - no previously-included directories found matching '.git*' 08:54:13 INFO - Successfully installed jsonschema functools32 08:54:13 INFO - Cleaning up... 08:54:13 INFO - Return code: 0 08:54:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:54:13 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')]} 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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')]} 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:13 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 08:54:13 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 08:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:54:13 INFO - Cleaning up... 08:54:13 INFO - Return code: 0 08:54:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:13 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')]} 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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')]} 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 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 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:13 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 08:54:13 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 08:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:15 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 08:54:15 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 08:54:15 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 08:54:15 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 08:54:15 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 08:54:15 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 08:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:16 INFO - Downloading docopt-0.6.1.tar.gz 08:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:16 INFO - Running setup.py install for blobuploader 08:54:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:16 INFO - Running setup.py install for requests 08:54:17 INFO - Running setup.py install for docopt 08:54:17 INFO - Successfully installed blobuploader requests docopt 08:54:17 INFO - Cleaning up... 08:54:17 INFO - Return code: 0 08:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:17 INFO - Using env: {'DISPLAY': ':0', 08:54:17 INFO - 'HOME': '/home/cltbld', 08:54:17 INFO - 'LANG': 'en_US.UTF-8', 08:54:17 INFO - 'LANGUAGE': 'en_US:en', 08:54:17 INFO - 'LOGNAME': 'cltbld', 08:54:17 INFO - 'MAIL': '/var/mail/cltbld', 08:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:17 INFO - 'MOZ_NO_REMOTE': '1', 08:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:17 INFO - 'NO_EM_RESTART': '1', 08:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:17 INFO - 'PWD': '/builds/slave/test', 08:54:17 INFO - 'SHELL': '/bin/bash', 08:54:17 INFO - 'SHLVL': '1', 08:54:17 INFO - 'TERM': 'linux', 08:54:17 INFO - 'TMOUT': '86400', 08:54:17 INFO - 'USER': 'cltbld', 08:54:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:17 INFO - '_': '/tools/buildbot/bin/python'} 08:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:17 INFO - Running setup.py (path:/tmp/pip-3JfqWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:17 INFO - Running setup.py (path:/tmp/pip-srMPFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:17 INFO - Running setup.py (path:/tmp/pip-Y8TePb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:17 INFO - Running setup.py (path:/tmp/pip-oYCtX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:17 INFO - Running setup.py (path:/tmp/pip-_mCriP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:17 INFO - Running setup.py (path:/tmp/pip-kVH6VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:17 INFO - Running setup.py (path:/tmp/pip-M0jpfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:17 INFO - Running setup.py (path:/tmp/pip-IEwdsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:18 INFO - Running setup.py (path:/tmp/pip-CKH2yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:18 INFO - Running setup.py (path:/tmp/pip-adq2F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:18 INFO - Running setup.py (path:/tmp/pip-zoR9o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:18 INFO - Running setup.py (path:/tmp/pip-N8A55Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:18 INFO - Running setup.py (path:/tmp/pip-XGw9Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:18 INFO - Running setup.py (path:/tmp/pip-BGL_Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:18 INFO - Running setup.py (path:/tmp/pip-SvspCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:18 INFO - Running setup.py (path:/tmp/pip-Bm2UJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:18 INFO - Running setup.py (path:/tmp/pip-UieYB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:18 INFO - Running setup.py install for manifestparser 08:54:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:18 INFO - Running setup.py install for mozcrash 08:54:18 INFO - Running setup.py install for mozdebug 08:54:18 INFO - Running setup.py install for mozdevice 08:54:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for mozfile 08:54:19 INFO - Running setup.py install for mozhttpd 08:54:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for mozinfo 08:54:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for mozInstall 08:54:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for mozleak 08:54:19 INFO - Running setup.py install for mozlog 08:54:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for moznetwork 08:54:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:19 INFO - Running setup.py install for mozprocess 08:54:19 INFO - Running setup.py install for mozprofile 08:54:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:20 INFO - Running setup.py install for mozrunner 08:54:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:20 INFO - Running setup.py install for mozscreenshot 08:54:20 INFO - Running setup.py install for moztest 08:54:20 INFO - Running setup.py install for mozversion 08:54:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:20 INFO - Cleaning up... 08:54:20 INFO - Return code: 0 08:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:20 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')]} 08:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:20 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')]} 08:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:20 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 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:20 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 08:54:20 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 08:54:20 INFO - Using env: {'DISPLAY': ':0', 08:54:20 INFO - 'HOME': '/home/cltbld', 08:54:20 INFO - 'LANG': 'en_US.UTF-8', 08:54:20 INFO - 'LANGUAGE': 'en_US:en', 08:54:20 INFO - 'LOGNAME': 'cltbld', 08:54:20 INFO - 'MAIL': '/var/mail/cltbld', 08:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:20 INFO - 'MOZ_NO_REMOTE': '1', 08:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:20 INFO - 'NO_EM_RESTART': '1', 08:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:20 INFO - 'PWD': '/builds/slave/test', 08:54:20 INFO - 'SHELL': '/bin/bash', 08:54:20 INFO - 'SHLVL': '1', 08:54:20 INFO - 'TERM': 'linux', 08:54:20 INFO - 'TMOUT': '86400', 08:54:20 INFO - 'USER': 'cltbld', 08:54:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:20 INFO - '_': '/tools/buildbot/bin/python'} 08:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:20 INFO - Running setup.py (path:/tmp/pip-ezzV3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:20 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)) 08:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:20 INFO - Running setup.py (path:/tmp/pip-N8vn_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:20 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)) 08:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:20 INFO - Running setup.py (path:/tmp/pip-okUs9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:20 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)) 08:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:20 INFO - Running setup.py (path:/tmp/pip-KUM7Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:20 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)) 08:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:20 INFO - Running setup.py (path:/tmp/pip-Lh6GOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:21 INFO - Running setup.py (path:/tmp/pip-R7_XR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:21 INFO - Running setup.py (path:/tmp/pip-3uy0Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:21 INFO - Running setup.py (path:/tmp/pip-L8R18w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:21 INFO - Running setup.py (path:/tmp/pip-aZq4Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:21 INFO - Running setup.py (path:/tmp/pip-90NFie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:21 INFO - Running setup.py (path:/tmp/pip-L_EwDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:21 INFO - Running setup.py (path:/tmp/pip-BtJWnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:21 INFO - Running setup.py (path:/tmp/pip-iJNwkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:21 INFO - Running setup.py (path:/tmp/pip-5pDiMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:21 INFO - Running setup.py (path:/tmp/pip-_i2Jwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:21 INFO - Running setup.py (path:/tmp/pip-EmKMYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:21 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)) 08:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:21 INFO - Running setup.py (path:/tmp/pip-Q4LoTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:21 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)) 08:54:21 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)) 08:54:21 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)) 08:54:21 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)) 08:54:21 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)) 08:54:21 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)) 08:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:21 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 08:54:21 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 08:54:21 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 08:54:21 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 08:54:21 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 08:54:21 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 08:54:23 INFO - Downloading blessings-1.6.tar.gz 08:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:23 INFO - Installing collected packages: blessings 08:54:23 INFO - Running setup.py install for blessings 08:54:24 INFO - Successfully installed blessings 08:54:24 INFO - Cleaning up... 08:54:24 INFO - Return code: 0 08:54:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:24 INFO - Reading from file tmpfile_stdout 08:54:24 INFO - Current package versions: 08:54:24 INFO - argparse == 1.2.1 08:54:24 INFO - blessings == 1.6 08:54:24 INFO - blobuploader == 1.2.4 08:54:24 INFO - docopt == 0.6.1 08:54:24 INFO - functools32 == 3.2.3-2 08:54:24 INFO - jsonschema == 2.5.1 08:54:24 INFO - manifestparser == 1.1 08:54:24 INFO - mozInstall == 1.12 08:54:24 INFO - mozcrash == 0.17 08:54:24 INFO - mozdebug == 0.1 08:54:24 INFO - mozdevice == 0.48 08:54:24 INFO - mozfile == 1.2 08:54:24 INFO - mozhttpd == 0.7 08:54:24 INFO - mozinfo == 0.9 08:54:24 INFO - mozleak == 0.1 08:54:24 INFO - mozlog == 3.3 08:54:24 INFO - moznetwork == 0.27 08:54:24 INFO - mozprocess == 0.23 08:54:24 INFO - mozprofile == 0.28 08:54:24 INFO - mozrunner == 6.12 08:54:24 INFO - mozscreenshot == 0.1 08:54:24 INFO - mozsystemmonitor == 0.3 08:54:24 INFO - moztest == 0.7 08:54:24 INFO - mozversion == 1.4 08:54:24 INFO - psutil == 3.1.1 08:54:24 INFO - requests == 1.2.3 08:54:24 INFO - wsgiref == 0.1.2 08:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:24 INFO - Using env: {'DISPLAY': ':0', 08:54:24 INFO - 'HOME': '/home/cltbld', 08:54:24 INFO - 'LANG': 'en_US.UTF-8', 08:54:24 INFO - 'LANGUAGE': 'en_US:en', 08:54:24 INFO - 'LOGNAME': 'cltbld', 08:54:24 INFO - 'MAIL': '/var/mail/cltbld', 08:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:24 INFO - 'MOZ_NO_REMOTE': '1', 08:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:24 INFO - 'NO_EM_RESTART': '1', 08:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:24 INFO - 'PWD': '/builds/slave/test', 08:54:24 INFO - 'SHELL': '/bin/bash', 08:54:24 INFO - 'SHLVL': '1', 08:54:24 INFO - 'TERM': 'linux', 08:54:24 INFO - 'TMOUT': '86400', 08:54:24 INFO - 'USER': 'cltbld', 08:54:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:24 INFO - '_': '/tools/buildbot/bin/python'} 08:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 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)) 08:54:24 INFO - Cleaning up... 08:54:24 INFO - Return code: 0 08:54:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:24 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 0x7fc278308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', '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 08:54:24 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 08:54:24 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 08:54:24 INFO - Using env: {'DISPLAY': ':0', 08:54:24 INFO - 'HOME': '/home/cltbld', 08:54:24 INFO - 'LANG': 'en_US.UTF-8', 08:54:24 INFO - 'LANGUAGE': 'en_US:en', 08:54:24 INFO - 'LOGNAME': 'cltbld', 08:54:24 INFO - 'MAIL': '/var/mail/cltbld', 08:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:24 INFO - 'MOZ_NO_REMOTE': '1', 08:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:24 INFO - 'NO_EM_RESTART': '1', 08:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:24 INFO - 'PWD': '/builds/slave/test', 08:54:24 INFO - 'SHELL': '/bin/bash', 08:54:24 INFO - 'SHLVL': '1', 08:54:24 INFO - 'TERM': 'linux', 08:54:24 INFO - 'TMOUT': '86400', 08:54:24 INFO - 'USER': 'cltbld', 08:54:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:24 INFO - '_': '/tools/buildbot/bin/python'} 08:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:54:24 INFO - Cleaning up... 08:54:24 INFO - Return code: 0 08:54:24 INFO - Running post-action listener: _resource_record_post_action 08:54:24 INFO - Running post-action listener: _start_resource_monitoring 08:54:24 INFO - Starting resource monitoring. 08:54:24 INFO - [mozharness: 2016-08-19 15:54:24.773090Z] Finished create-virtualenv step (success) 08:54:24 INFO - [mozharness: 2016-08-19 15:54:24.773632Z] Running install step. 08:54:24 INFO - Running pre-action listener: _resource_record_pre_action 08:54:24 INFO - Running main action method: install 08:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:24 INFO - Reading from file tmpfile_stdout 08:54:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:25 INFO - Reading from file tmpfile_stdout 08:54:25 INFO - Output received: 08:54:25 INFO - Usage: mozinstall [options] installer 08:54:25 INFO - Options: 08:54:25 INFO - -h, --help show this help message and exit 08:54:25 INFO - -d DEST, --destination=DEST 08:54:25 INFO - Directory to install application into. [default: 08:54:25 INFO - "/builds/slave/test"] 08:54:25 INFO - --app=APP Application being installed. [default: firefox] 08:54:25 INFO - mkdir: /builds/slave/test/build/application 08:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:54:41 INFO - Reading from file tmpfile_stdout 08:54:41 INFO - Output received: 08:54:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:54:41 INFO - Running post-action listener: _resource_record_post_action 08:54:41 INFO - [mozharness: 2016-08-19 15:54:41.149152Z] Finished install step (success) 08:54:41 INFO - [mozharness: 2016-08-19 15:54:41.149399Z] Running run-tests step. 08:54:41 INFO - Running pre-action listener: _resource_record_pre_action 08:54:41 INFO - Running main action method: run_tests 08:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:41 INFO - Python 2.7.3 08:54:41 INFO - Return code: 0 08:54:41 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290a090>, '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 0x290d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:54:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:54:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:54:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:41 INFO - Return code: 0 08:54:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:54:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:54:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:54:41 INFO - Using env: {'DISPLAY': ':0', 08:54:41 INFO - 'HOME': '/home/cltbld', 08:54:41 INFO - 'LANG': 'en_US.UTF-8', 08:54:41 INFO - 'LANGUAGE': 'en_US:en', 08:54:41 INFO - 'LOGNAME': 'cltbld', 08:54:41 INFO - 'MAIL': '/var/mail/cltbld', 08:54:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:41 INFO - 'MOZ_NO_REMOTE': '1', 08:54:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:41 INFO - 'NO_EM_RESTART': '1', 08:54:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:41 INFO - 'PWD': '/builds/slave/test', 08:54:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:41 INFO - 'SHELL': '/bin/bash', 08:54:41 INFO - 'SHLVL': '1', 08:54:41 INFO - 'TERM': 'linux', 08:54:41 INFO - 'TMOUT': '86400', 08:54:41 INFO - 'USER': 'cltbld', 08:54:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584', 08:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:41 INFO - '_': '/tools/buildbot/bin/python'} 08:54:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:54:41 INFO - mozversion application_buildid: 20160819065423 08:54:41 INFO - mozversion application_changeset: 74f332c38a6983707dd1f66d132baf45750d9c86 08:54:41 INFO - mozversion application_display_name: Nightly 08:54:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:41 INFO - mozversion application_name: Firefox 08:54:41 INFO - mozversion application_remotingname: firefox 08:54:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:41 INFO - mozversion application_vendor: Mozilla 08:54:41 INFO - mozversion application_version: 51.0a1 08:54:41 INFO - mozversion platform_buildid: 20160819065423 08:54:41 INFO - mozversion platform_changeset: 74f332c38a6983707dd1f66d132baf45750d9c86 08:54:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:41 INFO - mozversion platform_version: 51.0a1 08:54:41 INFO - using testdate: 1471622081 08:54:41 INFO - actual date: 1471622081 08:54:41 INFO - starting webserver on 'localhost:54020' 08:54:41 INFO - SUITE-START | Running 2 tests 08:54:41 INFO - TEST-START | dromaeo_css 08:54:41 INFO - operating with platform_type : linux_ 08:54:41 INFO - Initialising browser for dromaeo_css test... 08:54:41 INFO - TEST-INFO | started process 26083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8BQcp/profile http://localhost:54020/getInfo.html) 08:54:45 INFO - PROCESS | 26083 | __metrics Screen width/height:1600/1200 08:54:45 INFO - PROCESS | 26083 | colorDepth:24 08:54:45 INFO - PROCESS | 26083 | Browser inner width/height: 1024/697 08:54:45 INFO - PROCESS | 26083 | __metrics 08:54:46 INFO - PROCESS | 26083 | 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" 08:54:46 INFO - PROCESS | 26083 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:46 INFO - PROCESS | 26083 | console.error: PushService: 08:54:46 INFO - PROCESS | 26083 | stateChangeProcessEnqueue: Error transitioning state 08:54:46 INFO - PROCESS | 26083 | UnknownError 08:54:47 INFO - TEST-INFO | 26083: exit 0 08:54:47 INFO - Browser initialized. 08:54:47 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:47 INFO - TEST-INFO | started process 26162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8BQcp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:59 INFO - PROCESS | 26162 | RSS: Main: 157569024 08:54:59 INFO - PROCESS | 26162 | 08:55:50 INFO - PROCESS | 26162 | 1471622150479 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] 08:58:02 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54020/tests/dromaeo/cssquery-ext.html) 08:58:03 INFO - PROCESS | 26162 | RSS: Main: 236425216 08:58:03 INFO - PROCESS | 26162 | 09:01:06 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-ext.html (next: http://localhost:54020/tests/dromaeo/cssquery-jquery.html) 09:01:06 INFO - PROCESS | 26162 | RSS: Main: 247271424 09:01:06 INFO - PROCESS | 26162 | 09:04:09 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54020/tests/dromaeo/cssquery-mootools.html) 09:04:09 INFO - PROCESS | 26162 | RSS: Main: 189239296 09:04:09 INFO - PROCESS | 26162 | 09:07:11 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54020/tests/dromaeo/cssquery-prototype.html) 09:07:12 INFO - PROCESS | 26162 | RSS: Main: 190656512 09:07:12 INFO - PROCESS | 26162 | 09:10:15 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54020/tests/dromaeo/cssquery-yui.html) 09:10:16 INFO - PROCESS | 26162 | RSS: Main: 189767680 09:10:16 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | Cycle 1(1): loaded http://localhost:54020/tests/dromaeo/cssquery-yui.html (next: http://localhost:54020/tests/dromaeo/cssquery-dojo.html) 09:13:19 INFO - PROCESS | 26162 | RSS: Main: 269021184 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | __start_tp_report 09:13:19 INFO - PROCESS | 26162 | _x_x_mozilla_page_load 09:13:19 INFO - PROCESS | 26162 | _x_x_mozilla_page_load_details 09:13:19 INFO - PROCESS | 26162 | |i|pagename|runs| 09:13:19 INFO - PROCESS | 26162 | |0;dojo.html;2517.144170981866;2560.6287088372187;2590.2876708905037;2610.6475625790526;2612;4511.819527218916;4599.310103484479;4650.604698600619;4656.952185758211;4669.883252918675;4613.8154473821005;4656.697314674544;4668.836590719326;4742.027884283722;4768;4083.2241874043984;4277.67917406195;4366.410534577839;4379.737215767048;4419.646428285745;4386.912261754763;4407.603315701586;4422.248217802965;4428.512863585019;4431.26884064129;4202.138561594897;4239.978800106011;4248.490181178247;4324.286492728712;4324.8486302979245;4229.619334259932;4275.080857615628;4283.079137985317;4292.5492823253735;4338.284183109783;4272.786360681954;4303.010307629263;4309.181255561433;4316.762578058206;4316.892077698051;4694.155052090622;4698.624110071186;4703.811847526129;4712.222483290253;4713.575778179946;4788.7845046972625;4939.135651261051;4991;4996.150654388763;5054.545090941833;5077.441481437039;5083.872903177413;5084.9745751271375;5086.593072554224;5092.465291144414;4758.857234282942;4759.928601070987;4760.285957106462;4767.022760334088;4767.642426818003;4957.776900039435;5012.097822391932;5016.347874776256;5079.390473143247;5116.181410974301;4903.926441103386;4940.703557786473;4940.975295123501;4943.3573635427165;4949.282354058641;4986.0277245936695;4992.650514463952;5001.44984051754;5002.924956125661;5004.999000199975;4771.642126840501;4896.559309662148;4948.975255123702;4952.356193694796;5007.799688012512;4978.10394129053;4999.450060493343;5003.799848006039;5008.29883816266;5009.173486374707;4267.1892340455215;4267.97866010668;4271.67962402821;4276.059266961263;4280.101178752435;3578.570571531433;3640.635936406391;3641.1079285574674;3666.5233519642275;3763.2285381496727;4278.272693642089;4315.244832154361;4325.41606883073;4333.609975102193;4336.848210312624;4998.325226094504;5054.545090941833;5061.519155680205;5064.164412871834;5065.442801291855;4114.773687447159;4230.027093768451;4256;4263.701540892108;4300.139972005549;4511.278195488706;4522.706024108423;4529.207388706963;4533.773311334486;4536.115457485758;4758.405199350082;4762.880927976828;4764.4520880099235;4773.1408346497965;4779.569838714532;4906.828261010847;4953.356063711839;4983.72589507566;5009.348784657971;5083.2883396323805;4768.475467698481;4775.283707443911;4786.282057691375;4788.688735232199;4794.496577859274;4969.577585905238;4990.47600002009;4994.300797888226;5000.324956131021;5000.924986125138;4872.4153101628035;4955.207166853286;4979.327790748347;4992.80028798844;5058.772355244097;4930.309756634146;4939.036887806843;4944.728039957837;4946.332245147003;4946.455889852042;4906.043321552405;4916.8770780730765;4921.876953076058;4923.4584195737725;4927.655064145475;4593.150267200445;4707.411573553306;4750.311204875343;4764.071006153767;4820.119803558169;4900.068986892479;4930.5069493050405;4932.235503496964;4935.506449355035;4937.061958227925;4780.856574302777;4815.253635686474;4824.614030877591;4825.155597770306;4827.106985207748 09:13:19 INFO - PROCESS | 26162 | |1;ext.html;558.9469000444958;567.1039757183651;569.3424095170077;569.4391024840533;569.8945695046414;28856.71143288569;31663.525047124283;39515.80242098793;40685.18629627413;40700.79649601755;40971.795141024326;41301.58698413023;41310.17379652405;41326;41357.793211033975;7553.169151393342;7676.577788221645;7690.884636730453;7692.615369231544;7699.499532530368;7430.108386993568;9554.713358599252;9834.655787047455;9836.803263934717;10189.694309170736;9985.850212246822;10065.446400447972;10072.294939354248;10077.44574048427;10078.949605252;10066.69799906004;10130.797384052277;10140.543675534618;10140.746481337952;10144.239182061301;9961.850572241423;10016;10019.499025048792;10027.699169024942;10042.246831487595;38333.42499862504;38647.22705545873;38678.419823702665;38730.61269387298;38741.80629096865;2846.6157068795656;2993.790434669574;2997.460457117718;2998.880044798227;3149.322895577439;29067.82325725328;29366.41267174666;29400;29536.261593460335;29640.8517957411;2881.5101432756483;3133.6239651241767;3236.1689470553288;3250.1062207892783;3302.3725492156655;245823;245957;246025;246748;246774.76612617003;31211.219719507193;52087.958240834974;52559.21161182586;52593.7370313146;52680.20979685308;32042.839785800923;33649.15877103043;33748.156296092304;33771.49342759861;33790.155246119044;12137.089718270989;12202.267863928193;12214.572489962986;12269;12272.079594030483;9237.769055773659;9695.51522423876;9853.16248118918;9927.156191723785;9945.801083978424;7745.380369570421;7783.766487005286;7877.684892604231;7883.132855385903;7901.683932642745;2845.2886778305424;2965.3772707731187;3061.2040869374123;3091.2890035292007;3108.751299896003;815.6288888555812;854.9914500854912;856.1139220906457;890.5636238243214;930.8557173638097;27123;28368.432631347256;28471.43057138887;28708;28987.275318117216;911.1389736698889;914.1772404835701;928.6053427293373;941.0967166292065;994.786120983992;14773.92613036928;14900.329485173193;14932.850671493363;15009.849901500846;15197.468088617066;359813;364092;364369;364940;365030;49828.75085624621;50344;50354.49645503571;50407.74796126069;50473.49526504761;1080.5191689698165;1097.7859317433183;1109.9611513596985;1155.1163360029584;1173.3194747046693;20192.59614807725;31177.220569485944;31327.84336078305;31458.84270578724;32093.518597220595;46267;46590.53409465862;46604.30093548667;46697.29954050624;47017.2947405796;316339;319937;321128;321372;321737;25057.123000695618;25544.61683074718;25854.224373268833;25942.22173334803;25948.870255648602;41441.58558414498;42120.36819447772;42895.78552107344;42906.1418771629;42911.570884290755;35782;35959.64040359563;37130.8143459281;37781;37917.62082379141;35423;35838.820805895804;36207.275854482235;36373;36640.63359366479;35437.29125417529;35446.64553354433;36096.81951590225;36170;36575.45136823003;30988;33002;33145.50281745824;33211.50182747212;33329;23906.40233994164;24413.51172976566;24487.877560612083;24863.37841553903;24928.626070608592 09:13:19 INFO - PROCESS | 26162 | |2;jquery.html;346.8785924926278;354.49838478552863;362.78414343465647;366.60589865894167;392.55052964355815;13202.867971320284;15970.84029159708;16485.999999999985;18004.639907201847;18164.091795410244;15514.30185641646;15760.369585216578;15833.287502062407;15954.28205730742;16084.919575402108;4926.236433352827;5123.666961647499;5237.79048838046;5399.946000540003;5470.5350045246205;3477.2523907359914;5242.947570524284;5495.945040549604;5530.364008139055;5539.667619942797;5435.945640543583;5438.374586922515;5450.618456708032;5507.917381239265;5533.474319939599;5478.424765399615;5484.162805460176;5511.283533140706;5962.135490353874;5996.370381109964;5301.893962120736;5304.708241046741;5307.363116426015;5307.628466007381;5312.814051508218;12273.754524909451;17374.47876563705;19410.4176874694;20079.196832126698;20170.495737606532;1759.5777013516793;1848.1960347248855;1883.9811601883944;1900.064400501215;1919.4145785535407;9548.283878709055;9591.904080959172;10821.621243256448;12267.018638508987;13414.396352164078;1719.1662043908693;1744.5551384396897;1783.9197236124405;1786.97319540207;1796.9011704356255;66760.66619666871;67603;67720.6613966927;68131;68801.31198687998;8053.15441878606;8452.070272270046;8546.487210767375;8548.102449242864;8802.647894084164;11342.432878356049;11493.195476316745;11494.195406321645;11509.309441433541;11523.711907202387;6400.199975003125;6542.934570654328;6587;6734.865302693918;6738.090357801634;6511.088447617338;6541.2150541934325;6679.398854103154;6692.330766923366;6714.462842972648;3652.8493524539685;3698.4082546792924;3701.426278926717;3747.6439738224826;3826.6364695353896;1775.6448710258;1782.10003948008;1785.0806834480254;1824.6441943821094;1827.954301142482;779.6608475313257;790.1348023913805;875.4003507597316;888.1163242573681;906.8639704044446;16665.666686666198;16719.83280167207;16763.664726705396;16922.661546769243;17734.733978990327;838.2455789789117;842.3640151685561;848.809017970964;891.5809569502323;905.2215095018279;9303.395279306824;9720.368176068532;9754.902450975542;9822.73783754126;9834.950825245827;363069;371606.38856257126;376176.5955851126;378517;381096;62991.685041575416;72973.63513182507;74211;74991.62504187445;79133.60433197797;900.8603666431583;906.4878343735768;942.707760594218;944.0559440559441;951.7620594851287;15679.68640627204;15719.371225151323;16469.670606587562;16513.174341283127;16745.413910513074;36705.265894681426;36856.44715329326;37723.622763773106;37936;38486.80756596199;50431;50536;52016.479835201164;52921.7353913228;53536.73231633973;7278.199398066103;7369.968204451488;7487.700491980478;7489.70041198346;7732.574708391093;8455.788605284917;10664.200184986003;10787.838182427427;10958.726031849268;11962.222455540363;9753.219742420732;9895.901040989498;10190.643327483502;10451.94774026125;10726.302790318605;9970.950145249228;10087;10090.545925433225;10203.795924081625;10211.387316761018;9590.66432674853;10100.747481313027;10104.545295461869;10174.694759157237;10719.89280107189;7020.508564400443;7088.645567721696;7166.426685865014;7217.67520461591;7309.853802924018;8967.910320896708;9893.25800564946;10180.541875615467;10258.794824103326;10279.486025698834 09:13:19 INFO - PROCESS | 26162 | |3;mootools.html;1342.4227582139679;1393.714288570843;1424.8147740793695;1633.126277441569;1646.7365221564553;7186.8203294917585;7689.923100768998;7703.961480192605;7709.884351734729;7712.0745510538745;6655.567388119769;6871.931280687191;6872.037914691935;7075.929240707592;7543.094828620573;1880.219708820841;2123.851330406872;2191.627423338028;2198.0658220256405;2205.6250437425674;2140.176032227588;2167.6098302305577;2175.5431359414542;2179.9891000544976;2181.1929586053184;2174.4455163933176;2178.891055447229;2180.4221881201493;2181.0839447432118;2182.8035476807086;2107.6417009108486;2109.9766613192587;2150.924717634891;2154.2460138951396;2157.4390658428765;2099.1078791513546;2117.68234764785;2124.8618839775363;2125.744910610721;2129.968050479244;7565;7696.692132314756;7698;7704.922950770532;7728.381729461629;4302.913941721179;4435.62297204738;4441.156180325728;4450.176717307276;4451;2727.890884364623;2878.2372671242138;2889.5376739721755;2914.1403286030672;2940.6618238902374;905.7056456651615;910.4082346474778;922.2437601167046;950.4154944708954;959.3572306554626;10467.947660261727;10468.790624187473;10474.21443391741;10475.633352832614;10483.947580262049;3882.417637354363;4193.193755649488;4238.3430568261965;4313.158934007901;4332.740035597874;9139.81720365589;9165;9179.495127768037;9181.311401644904;9182.724518264462;4420.7126536775;4421.734695918255;4425.645948324191;4426.026274219666;4435.556444355603;3950.288947989332;3971.5829837867186;3990.2219067281603;3994.1612261425425;4002.8799136025964;3641.599424063351;3642.653947874948;3722.9441558376648;3765.5293088363956;3765.9058523536582;1216.3614102596032;1217.1601594899491;1233.4326209943526;1241.422738426636;1248.2399816259212;704.2886684448744;752.2627824731793;791.2285521616493;802.7872613757359;817.1817705604981;5010.674306170087;5057.671251368649;5074.13739664258;5104.872378190575;5327.573794096541;398.82252397682754;399.3430806323581;407.4377359244224;418.7257346438088;422.8815931539174;3383.3233353329433;3428.9485657715154;3437.3812713711773;3441.5353927219503;3541.911452213715;9075.636974521078;9547;9563.234941204826;9579.425234485952;9594.712158635251;9518.762030949281;9527.571259293349;9531.189848862785;9536.094071063239;9536.570854311572;7012.088428504262;7101.041359416516;7108.644567771694;7121.109861267341;7122.60825654594;4973.104841128632;5019.7490125494305;5038.244263360525;5063.797448102035;5202.271681964452;8464.830703385775;8684.001339845998;8738.34462415334;8872.467651940904;8945.73162805117;8395.95802020986;8617.353698472514;8687.956560217159;8977.551122443982;9002.639894404412;6510.251321098134;6707.5304728668525;6776.051352810709;6782.626955517494;6788.626625535643;7415.8887616684715;7489;7489.887651685338;7494.475386722877;7505.399568034435;6445.419912207736;6488.188976377953;6522.739090436329;6537.542372034102;6672.8999065013095;6499.480041596756;6518.315576864361;6629;6644.634545100066;6751.291114432914;6027.517798576191;6063.060225664853;6094.268687757498;6113.57204995646;6128.938710612837;4485.416895803524;4493.662975276802;4527.547245275446;4544.477385100756;4554.407926969473;4436.82252709888;4437.733735975852;4547.795349209227;4586.220342541709;4687.624990000723 09:13:19 INFO - PROCESS | 26162 | |4;prototype.html;290.403221380064;293.39121323254244;302.75628119363904;302.82436187011524;305.5783019433182;4839.830605928793;4848.709077455355;4883.632582876796;4887.486813884544;4906.190478571036;4736.573708366246;4795.880102997427;4818.951810481894;4833.347498087757;4859.854204373865;3799.601041890603;3808.1812410331772;3820.4842346283244;3826.6364695353896;3838.2323535292912;3569.2147727500037;3643.3988391915304;3857.1514266861245;3863.343231650612;3863.690904727615;3228.6771322867644;3629.8366573504254;3637.94543081854;3643.071016890689;3723.2925744108534;3658.4878117063768;3717.126475278307;3725.1432170600915;3737.5701794293595;3752.418375151856;3306.2230375861895;3307.7023067924;3308.520264561649;3308.669133086696;3316.5688460500223;4479.686421950465;4504.752238626874;4650.25595904657;4651.5813576778255;4686.95313046872;4242;4247.532771395144;4252.298370768819;4256.701705979675;4261.722988005769;4975.278584605248;4985.5513003829465;4986.152354099811;4997.250412438127;5006.774695138691;3562.6793588576893;3643.4352675335367;3651.6713495785507;3657.579378371495;3669.4679271505747;5167.638265321467;5185.403678576974;5193.766280517386;5204.583633309327;5207.60942929278;3708.1100535871196;3711.2020915503294;3715.405535114369;3755.2114056048536;3768.378217594121;3801.258754542893;3805.486259355007;3809.5047643806683;3816.6183381661613;3818.7326887118193;4188.162367526507;4267.8719638410275;4291.120320334324;4301.505326887385;4318.589733975267;4968.484612193316;4984;4986.501349864984;4986.825461108916;4989;1301.7958388490797;1321.1346567997978;1322.821419108408;1324.3510679766846;1325.7812460944028;826.7519744076753;858.0089996054567;869.4956924983494;886.7251152142857;886.7694399456059;3947.50656167979;3962.445257663929;3971.7091945117954;3973.6225058619384;3979.5525751662517;4541.114482675913;4546.863284178955;4561.722717639066;4581.633469322446;4587.8623641290815;3955.20895820837;3979.4826672532386;3986.5216174059296;4007.979960100181;4019.8593049243723;2297.8391512593957;2425.7210420801835;2430.5989511730368;2433.7322894481595;2485.3662316109276;4316.719413238129;4323.308270676676;4328.956710432855;4335.393044973706;4339.134172305876;4667.579917807414;4679.549339704702;4976.303317535548;5012.298278241049;5234.450382709837;4844.273358996179;4854.78153483087;4861.416630004422;4869.561739443467;4882.780274887638;5104.642675012714;5124.128898087409;5148.150555158357;5152.5877929766275;5159.17453207485;4808.486845686046;5041.470645582308;5046.57104146137;5049.2173713074535;5082.2122571001555;4884.682495637772;4905.926411103907;4910.582600479;4910.993246384412;4927.1377508935075;3737.9065523362133;3742.6070262622034;3743.1016556026902;3744.9438258425603;3750.2499500099543;4881.9023619528125;5121.129408000724;5154.943236636405;5186.4035635902355;5186.4294927557185;4979.178435558092;5002.324686167321;5005.34930459038;5007.824726134568;5008.173651347487;5006.249062640633;5007.474215207497;5013.774380152829;5014.824481143289;5016.2224855147515;4688.531146885284;4912.1158191525865;4935;4948.851534453972;4951.801927922843;5039.924401133912;5052.964142350883;5057.342545469065;5061;5066.5693416058575;4943.678660887174;4984.800607975641;4986.6010719143105;4991.850244492671;5036.294918711456 09:13:19 INFO - PROCESS | 26162 | |5;yui.html;606.257334764913;622.1321256846699;625.6089943785134;633.8352028472597;719.1442183801279;12745.553905613306;12751.681207969794;12846.614601561945;12991.545295914644;13272.46910123595;13165.934170329136;13335.199888006702;13343.1994080355;13353.53262635808;13356.198628082298;618.5546406587273;754.4869488747636;776.6737970052563;780.2314720000795;780.4575819805237;751.8458715963214;775.9456838021341;777.3586790897504;786.3748320085546;787.1027029186703;820.5486982159788;822.8230930349973;823.7487566292278;823.9423240373176;824.1881746479713;652.3052948609716;822.4489591973393;822.7984143884727;823.3043078598574;823.5593957232882;569.6126633888954;584.9824505264849;585.9267591551056;587.2219309415042;587.6209844650219;11509.76980460386;11532.481038353295;11856.22934509254;11887;11985.760284794342;12489.75020499594;12884.80672789909;13300.667483312898;13420.731585368336;13510.392032358568;11890.821637675443;12001.879981200163;12202.633920982385;12520.436580353906;12592;3322.1362445764034;3460.740444466675;4228.238916994939;4269.829206831723;4343.6959412841115;57764.13353799696;58260.70869645667;58712.70643646797;59298.99999999957;59868.70065649644;10542.262041657164;10820.56717731282;10877.292975956538;10939.56241750321;11395.25930814511;18885.622287554448;18918.148683309286;18937.242510299708;18942.715859262124;18943;6892.689828957709;6959.6868140933775;7083.362497375261;7180.928190718026;7195.92804071963;3612.4942508048894;3660.5973342932257;3716.2567486502808;3739.513863197821;3807.2195199983935;2997.520396736512;3085.799423037495;3112.9533057004164;3113.377324535102;3115.922101947424;506.8403452912321;507.14545990006957;510.67316917173036;512.1038183179436;519.1693290734794;532.2761044978826;536.5010540197576;538.3405328472589;541.8049502179213;559.9132134519156;7765.378769698411;7927.326177274881;8103.149169337253;8379.832403351898;8740.169683880022;510.20917577754335;519.7713006277302;575.9882418952019;576.6626523483725;603.6830663901399;3961.80505451089;4128.401381799622;4140.330588399507;4143.668506519532;4256.893577660521;76983.61508192535;80287;80725;83951;98660;78368.60815695886;78490.21509784943;78979;79690.6402167726;83471.5826420864;43210.351844722354;43380.78309608432;43557.564424355354;44007;67630.99999999901;8291.33669306442;8364.289035431813;8540.786480338042;8674.566271686264;9281.39670921388;42508.14983700247;42747.57252427436;43324.56675433331;43458.782706087535;43994;51794;53595.732021339645;54376;59230.703846480494;59981.70009149926;10271.794564108826;10293.794124117625;10362.896371036193;11771.117166212398;11914.404279785802;12793.168444051107;13259.734805304033;13567.457301708217;13765.449382024606;13814.37835297394;10824.56701731922;11586.188966772583;11629.459836555441;11661.825072623747;12003.939980300043;11720.765584688088;11782.293062416282;11845.111616628616;12076.33580153065;12650.05124615639;11675.941620291844;12192.878071219175;12496.937515312366;12509.061095530207;12528.123031387715;9092.227160691415;9359.204467620328;9432.62269509212;9781.706548803548;9907.851382229128;8877.955610221907;9069.77325566866;9459.337846350689;9627.597647564291;9786.168175705145 09:13:19 INFO - PROCESS | 26162 | __end_tp_report 09:13:19 INFO - PROCESS | 26162 | __start_cc_report 09:13:19 INFO - PROCESS | 26162 | _x_x_mozilla_cycle_collect,1019 09:13:19 INFO - PROCESS | 26162 | __end_cc_report 09:13:19 INFO - PROCESS | 26162 | __startTimestamp1471623199797__endTimestamp 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | ------- Summary: start ------- 09:13:19 INFO - PROCESS | 26162 | Number of tests: 6 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#0] dojo.html Cycles:165 Average:4628.47 Median:4768.48 stddev:493.25 (10.3%) stddev-sans-first:466.13 09:13:19 INFO - PROCESS | 26162 | Values: 2517.1 2560.6 2590.3 2610.6 2612.0 4511.8 4599.3 4650.6 4657.0 4669.9 4613.8 4656.7 4668.8 4742.0 4768.0 4083.2 4277.7 4366.4 4379.7 4419.6 4386.9 4407.6 4422.2 4428.5 4431.3 4202.1 4240.0 4248.5 4324.3 4324.8 4229.6 4275.1 4283.1 4292.5 4338.3 4272.8 4303.0 4309.2 4316.8 4316.9 4694.2 4698.6 4703.8 4712.2 4713.6 4788.8 4939.1 4991.0 4996.2 5054.5 5077.4 5083.9 5085.0 5086.6 5092.5 4758.9 4759.9 4760.3 4767.0 4767.6 4957.8 5012.1 5016.3 5079.4 5116.2 4903.9 4940.7 4941.0 4943.4 4949.3 4986.0 4992.7 5001.4 5002.9 5005.0 4771.6 4896.6 4949.0 4952.4 5007.8 4978.1 4999.5 5003.8 5008.3 5009.2 4267.2 4268.0 4271.7 4276.1 4280.1 3578.6 3640.6 3641.1 3666.5 3763.2 4278.3 4315.2 4325.4 4333.6 4336.8 4998.3 5054.5 5061.5 5064.2 5065.4 4114.8 4230.0 4256.0 4263.7 4300.1 4511.3 4522.7 4529.2 4533.8 4536.1 4758.4 4762.9 4764.5 4773.1 4779.6 4906.8 4953.4 4983.7 5009.3 5083.3 4768.5 4775.3 4786.3 4788.7 4794.5 4969.6 4990.5 4994.3 5000.3 5000.9 4872.4 4955.2 4979.3 4992.8 5058.8 4930.3 4939.0 4944.7 4946.3 4946.5 4906.0 4916.9 4921.9 4923.5 4927.7 4593.2 4707.4 4750.3 4764.1 4820.1 4900.1 4930.5 4932.2 4935.5 4937.1 4780.9 4815.3 4824.6 4825.2 4827.1 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#1] ext.html Cycles:180 Average:45852.57 Median:33780.82 stddev:82569.70 (244.4%) stddev-sans-first:82731.30 09:13:19 INFO - PROCESS | 26162 | Values: 558.9 567.1 569.3 569.4 569.9 28856.7 31663.5 39515.8 40685.2 40700.8 40971.8 41301.6 41310.2 41326.0 41357.8 7553.2 7676.6 7690.9 7692.6 7699.5 7430.1 9554.7 9834.7 9836.8 10189.7 9985.9 10065.4 10072.3 10077.4 10078.9 10066.7 10130.8 10140.5 10140.7 10144.2 9961.9 10016.0 10019.5 10027.7 10042.2 38333.4 38647.2 38678.4 38730.6 38741.8 2846.6 2993.8 2997.5 2998.9 3149.3 29067.8 29366.4 29400.0 29536.3 29640.9 2881.5 3133.6 3236.2 3250.1 3302.4 245823.0 245957.0 246025.0 246748.0 246774.8 31211.2 52088.0 52559.2 52593.7 52680.2 32042.8 33649.2 33748.2 33771.5 33790.2 12137.1 12202.3 12214.6 12269.0 12272.1 9237.8 9695.5 9853.2 9927.2 9945.8 7745.4 7783.8 7877.7 7883.1 7901.7 2845.3 2965.4 3061.2 3091.3 3108.8 815.6 855.0 856.1 890.6 930.9 27123.0 28368.4 28471.4 28708.0 28987.3 911.1 914.2 928.6 941.1 994.8 14773.9 14900.3 14932.9 15009.8 15197.5 359813.0 364092.0 364369.0 364940.0 365030.0 49828.8 50344.0 50354.5 50407.7 50473.5 1080.5 1097.8 1110.0 1155.1 1173.3 20192.6 31177.2 31327.8 31458.8 32093.5 46267.0 46590.5 46604.3 46697.3 47017.3 316339.0 319937.0 321128.0 321372.0 321737.0 25057.1 25544.6 25854.2 25942.2 25948.9 41441.6 42120.4 42895.8 42906.1 42911.6 35782.0 35959.6 37130.8 37781.0 37917.6 35423.0 35838.8 36207.3 36373.0 36640.6 35437.3 35446.6 36096.8 36170.0 36575.5 30988.0 33002.0 33145.5 33211.5 33329.0 23906.4 24413.5 24487.9 24863.4 24928.6 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#2] jquery.html Cycles:180 Average:23497.54 Median:28570.07 stddev:61829.19 (216.4%) stddev-sans-first:61978.21 09:13:19 INFO - PROCESS | 26162 | Values: 346.9 354.5 362.8 366.6 392.6 13202.9 15970.8 16486.0 18004.6 18164.1 15514.3 15760.4 15833.3 15954.3 16084.9 4926.2 5123.7 5237.8 5399.9 5470.5 3477.3 5242.9 5495.9 5530.4 5539.7 5435.9 5438.4 5450.6 5507.9 5533.5 5478.4 5484.2 5511.3 5962.1 5996.4 5301.9 5304.7 5307.4 5307.6 5312.8 12273.8 17374.5 19410.4 20079.2 20170.5 1759.6 1848.2 1884.0 1900.1 1919.4 9548.3 9591.9 10821.6 12267.0 13414.4 1719.2 1744.6 1783.9 1787.0 1796.9 66760.7 67603.0 67720.7 68131.0 68801.3 8053.2 8452.1 8546.5 8548.1 8802.6 11342.4 11493.2 11494.2 11509.3 11523.7 6400.2 6542.9 6587.0 6734.9 6738.1 6511.1 6541.2 6679.4 6692.3 6714.5 3652.8 3698.4 3701.4 3747.6 3826.6 1775.6 1782.1 1785.1 1824.6 1828.0 779.7 790.1 875.4 888.1 906.9 16665.7 16719.8 16763.7 16922.7 17734.7 838.2 842.4 848.8 891.6 905.2 9303.4 9720.4 9754.9 9822.7 9835.0 363069.0 371606.4 376176.6 378517.0 381096.0 62991.7 72973.6 74211.0 74991.6 79133.6 900.9 906.5 942.7 944.1 951.8 15679.7 15719.4 16469.7 16513.2 16745.4 36705.3 36856.4 37723.6 37936.0 38486.8 50431.0 50536.0 52016.5 52921.7 53536.7 7278.2 7370.0 7487.7 7489.7 7732.6 8455.8 10664.2 10787.8 10958.7 11962.2 9753.2 9895.9 10190.6 10451.9 10726.3 9971.0 10087.0 10090.5 10203.8 10211.4 9590.7 10100.7 10104.5 10174.7 10719.9 7020.5 7088.6 7166.4 7217.7 7309.9 8967.9 9893.3 10180.5 10258.8 10279.5 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#3] mootools.html Cycles:180 Average:5020.82 Median:4991.89 stddev:2836.19 (56.8%) stddev-sans-first:2830.68 09:13:19 INFO - PROCESS | 26162 | Values: 1342.4 1393.7 1424.8 1633.1 1646.7 7186.8 7689.9 7704.0 7709.9 7712.1 6655.6 6871.9 6872.0 7075.9 7543.1 1880.2 2123.9 2191.6 2198.1 2205.6 2140.2 2167.6 2175.5 2180.0 2181.2 2174.4 2178.9 2180.4 2181.1 2182.8 2107.6 2110.0 2150.9 2154.2 2157.4 2099.1 2117.7 2124.9 2125.7 2130.0 7565.0 7696.7 7698.0 7704.9 7728.4 4302.9 4435.6 4441.2 4450.2 4451.0 2727.9 2878.2 2889.5 2914.1 2940.7 905.7 910.4 922.2 950.4 959.4 10467.9 10468.8 10474.2 10475.6 10483.9 3882.4 4193.2 4238.3 4313.2 4332.7 9139.8 9165.0 9179.5 9181.3 9182.7 4420.7 4421.7 4425.6 4426.0 4435.6 3950.3 3971.6 3990.2 3994.2 4002.9 3641.6 3642.7 3722.9 3765.5 3765.9 1216.4 1217.2 1233.4 1241.4 1248.2 704.3 752.3 791.2 802.8 817.2 5010.7 5057.7 5074.1 5104.9 5327.6 398.8 399.3 407.4 418.7 422.9 3383.3 3428.9 3437.4 3441.5 3541.9 9075.6 9547.0 9563.2 9579.4 9594.7 9518.8 9527.6 9531.2 9536.1 9536.6 7012.1 7101.0 7108.6 7121.1 7122.6 4973.1 5019.7 5038.2 5063.8 5202.3 8464.8 8684.0 8738.3 8872.5 8945.7 8396.0 8617.4 8688.0 8977.6 9002.6 6510.3 6707.5 6776.1 6782.6 6788.6 7415.9 7489.0 7489.9 7494.5 7505.4 6445.4 6488.2 6522.7 6537.5 6672.9 6499.5 6518.3 6629.0 6644.6 6751.3 6027.5 6063.1 6094.3 6113.6 6128.9 4485.4 4493.7 4527.5 4544.5 4554.4 4436.8 4437.7 4547.8 4586.2 4687.6 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#4] prototype.html Cycles:180 Average:4102.60 Median:4584.75 stddev:1189.66 (25.9%) stddev-sans-first:1158.07 09:13:19 INFO - PROCESS | 26162 | Values: 290.4 293.4 302.8 302.8 305.6 4839.8 4848.7 4883.6 4887.5 4906.2 4736.6 4795.9 4819.0 4833.3 4859.9 3799.6 3808.2 3820.5 3826.6 3838.2 3569.2 3643.4 3857.2 3863.3 3863.7 3228.7 3629.8 3637.9 3643.1 3723.3 3658.5 3717.1 3725.1 3737.6 3752.4 3306.2 3307.7 3308.5 3308.7 3316.6 4479.7 4504.8 4650.3 4651.6 4687.0 4242.0 4247.5 4252.3 4256.7 4261.7 4975.3 4985.6 4986.2 4997.3 5006.8 3562.7 3643.4 3651.7 3657.6 3669.5 5167.6 5185.4 5193.8 5204.6 5207.6 3708.1 3711.2 3715.4 3755.2 3768.4 3801.3 3805.5 3809.5 3816.6 3818.7 4188.2 4267.9 4291.1 4301.5 4318.6 4968.5 4984.0 4986.5 4986.8 4989.0 1301.8 1321.1 1322.8 1324.4 1325.8 826.8 858.0 869.5 886.7 886.8 3947.5 3962.4 3971.7 3973.6 3979.6 4541.1 4546.9 4561.7 4581.6 4587.9 3955.2 3979.5 3986.5 4008.0 4019.9 2297.8 2425.7 2430.6 2433.7 2485.4 4316.7 4323.3 4329.0 4335.4 4339.1 4667.6 4679.5 4976.3 5012.3 5234.5 4844.3 4854.8 4861.4 4869.6 4882.8 5104.6 5124.1 5148.2 5152.6 5159.2 4808.5 5041.5 5046.6 5049.2 5082.2 4884.7 4905.9 4910.6 4911.0 4927.1 3737.9 3742.6 3743.1 3744.9 3750.2 4881.9 5121.1 5154.9 5186.4 5186.4 4979.2 5002.3 5005.3 5007.8 5008.2 5006.2 5007.5 5013.8 5014.8 5016.2 4688.5 4912.1 4935.0 4948.9 4951.8 5039.9 5053.0 5057.3 5061.0 5066.6 4943.7 4984.8 4986.6 4991.9 5036.3 09:13:19 INFO - PROCESS | 26162 | 09:13:19 INFO - PROCESS | 26162 | [#5] yui.html Cycles:180 Average:16305.95 Median:508.68 stddev:21952.93 (4315.7%) stddev-sans-first:21982.86 09:13:19 INFO - PROCESS | 26162 | Values: 606.3 622.1 625.6 633.8 719.1 12745.6 12751.7 12846.6 12991.5 13272.5 13165.9 13335.2 13343.2 13353.5 13356.2 618.6 754.5 776.7 780.2 780.5 751.8 775.9 777.4 786.4 787.1 820.5 822.8 823.7 823.9 824.2 652.3 822.4 822.8 823.3 823.6 569.6 585.0 585.9 587.2 587.6 11509.8 11532.5 11856.2 11887.0 11985.8 12489.8 12884.8 13300.7 13420.7 13510.4 11890.8 12001.9 12202.6 12520.4 12592.0 3322.1 3460.7 4228.2 4269.8 4343.7 57764.1 58260.7 58712.7 59299.0 59868.7 10542.3 10820.6 10877.3 10939.6 11395.3 18885.6 18918.1 18937.2 18942.7 18943.0 6892.7 6959.7 7083.4 7180.9 7195.9 3612.5 3660.6 3716.3 3739.5 3807.2 2997.5 3085.8 3113.0 3113.4 3115.9 506.8 507.1 510.7 512.1 519.2 532.3 536.5 538.3 541.8 559.9 7765.4 7927.3 8103.1 8379.8 8740.2 510.2 519.8 576.0 576.7 603.7 3961.8 4128.4 4140.3 4143.7 4256.9 76983.6 80287.0 80725.0 83951.0 98660.0 78368.6 78490.2 78979.0 79690.6 83471.6 43210.4 43380.8 43557.6 44007.0 67631.0 8291.3 8364.3 8540.8 8674.6 9281.4 42508.1 42747.6 43324.6 43458.8 43994.0 51794.0 53595.7 54376.0 59230.7 59981.7 10271.8 10293.8 10362.9 11771.1 11914.4 12793.2 13259.7 13567.5 13765.4 13814.4 10824.6 11586.2 11629.5 11661.8 12003.9 11720.8 11782.3 11845.1 12076.3 12650.1 11675.9 12192.9 12496.9 12509.1 12528.1 9092.2 9359.2 9432.6 9781.7 9907.9 8878.0 9069.8 9459.3 9627.6 9786.2 09:13:19 INFO - PROCESS | 26162 | -------- Summary: end -------- 09:13:19 INFO - PROCESS | 26162 | 09:13:20 INFO - TEST-INFO | 26162: exit 0 09:13:20 INFO - TEST-OK | dromaeo_css | took 1119163ms 09:13:20 INFO - TEST-START | kraken 09:13:20 INFO - operating with platform_type : linux_ 09:13:20 INFO - Initialising browser for kraken test... 09:13:20 INFO - TEST-INFO | started process 26464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpapoMEs/profile http://localhost:54020/getInfo.html) 09:13:24 INFO - PROCESS | 26464 | __metrics Screen width/height:1600/1200 09:13:24 INFO - PROCESS | 26464 | colorDepth:24 09:13:24 INFO - PROCESS | 26464 | Browser inner width/height: 1024/697 09:13:24 INFO - PROCESS | 26464 | __metrics 09:13:25 INFO - PROCESS | 26464 | 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" 09:13:25 INFO - PROCESS | 26464 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:25 INFO - PROCESS | 26464 | console.error: PushService: 09:13:25 INFO - PROCESS | 26464 | stateChangeProcessEnqueue: Error transitioning state 09:13:25 INFO - PROCESS | 26464 | UnknownError 09:13:26 INFO - TEST-INFO | 26464: exit 0 09:13:26 INFO - Browser initialized. 09:13:26 INFO - Running cycle 1/1 for kraken test... 09:13:26 INFO - TEST-INFO | started process 26543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpapoMEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:38 INFO - PROCESS | 26543 | RSS: Main: 157552640 09:13:38 INFO - PROCESS | 26543 | 09:13:40 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54020/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:41 INFO - PROCESS | 26543 | RSS: Main: 212451328 09:13:41 INFO - PROCESS | 26543 | 09:13:44 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54020/tests/kraken/driver.html?testName=audio-dft) 09:13:45 INFO - PROCESS | 26543 | RSS: Main: 190058496 09:13:45 INFO - PROCESS | 26543 | 09:13:48 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54020/tests/kraken/driver.html?testName=audio-fft) 09:13:49 INFO - PROCESS | 26543 | RSS: Main: 270147584 09:13:49 INFO - PROCESS | 26543 | 09:13:51 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54020/tests/kraken/driver.html?testName=audio-oscillator) 09:13:51 INFO - PROCESS | 26543 | RSS: Main: 179712000 09:13:51 INFO - PROCESS | 26543 | 09:13:54 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:54 INFO - PROCESS | 26543 | RSS: Main: 184201216 09:13:54 INFO - PROCESS | 26543 | 09:13:57 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54020/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:58 INFO - PROCESS | 26543 | RSS: Main: 221229056 09:13:58 INFO - PROCESS | 26543 | 09:14:01 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54020/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:02 INFO - PROCESS | 26543 | RSS: Main: 220585984 09:14:02 INFO - PROCESS | 26543 | 09:14:05 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54020/tests/kraken/driver.html?testName=json-parse-financial) 09:14:06 INFO - PROCESS | 26543 | RSS: Main: 219873280 09:14:06 INFO - PROCESS | 26543 | 09:14:07 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:08 INFO - PROCESS | 26543 | RSS: Main: 182849536 09:14:08 INFO - PROCESS | 26543 | 09:14:10 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:10 INFO - PROCESS | 26543 | RSS: Main: 190316544 09:14:10 INFO - PROCESS | 26543 | 09:14:13 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:13 INFO - PROCESS | 26543 | RSS: Main: 194306048 09:14:13 INFO - PROCESS | 26543 | 09:14:16 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:17 INFO - PROCESS | 26543 | RSS: Main: 189280256 09:14:17 INFO - PROCESS | 26543 | 09:14:20 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:20 INFO - PROCESS | 26543 | RSS: Main: 192761856 09:14:20 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | Cycle 1(1): loaded http://localhost:54020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54020/tests/kraken/driver.html?testName=ai-astar) 09:14:22 INFO - PROCESS | 26543 | RSS: Main: 243126272 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | __start_tp_report 09:14:22 INFO - PROCESS | 26543 | _x_x_mozilla_page_load 09:14:22 INFO - PROCESS | 26543 | _x_x_mozilla_page_load_details 09:14:22 INFO - PROCESS | 26543 | |i|pagename|runs| 09:14:22 INFO - PROCESS | 26543 | |0;ai-astar;107;113;115;117;114;115;118;115;119;113 09:14:22 INFO - PROCESS | 26543 | |1;audio-beat-detection;147;120;125;199;123;123;149;121;163;128 09:14:22 INFO - PROCESS | 26543 | |2;audio-dft;161;161;160;161;161;161;162;161;161;162 09:14:22 INFO - PROCESS | 26543 | |3;audio-fft;76;76;77;119;78;76;75;75;99;73 09:14:22 INFO - PROCESS | 26543 | |4;audio-oscillator;86;85;129;86;86;87;124;85;86;133 09:14:22 INFO - PROCESS | 26543 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 09:14:22 INFO - PROCESS | 26543 | |6;imaging-darkroom;146;147;147;146;147;147;146;146;147;146 09:14:22 INFO - PROCESS | 26543 | |7;imaging-desaturate;94;96;95;94;95;95;95;95;95;95 09:14:22 INFO - PROCESS | 26543 | |8;json-parse-financial;63;64;65;64;65;65;65;65;65;66 09:14:22 INFO - PROCESS | 26543 | |9;json-stringify-tinderbox;66;66;66;66;66;66;65;66;66;76 09:14:22 INFO - PROCESS | 26543 | |10;stanford-crypto-aes;83;81;82;83;83;82;82;83;82;82 09:14:22 INFO - PROCESS | 26543 | |11;stanford-crypto-ccm;137;147;141;134;140;136;132;132;162;131 09:14:22 INFO - PROCESS | 26543 | |12;stanford-crypto-pbkdf2;171;176;171;171;178;178;171;174;175;169 09:14:22 INFO - PROCESS | 26543 | |13;stanford-crypto-sha256-iterative;69;68;72;68;71;67;67;68;70;65 09:14:22 INFO - PROCESS | 26543 | __end_tp_report 09:14:22 INFO - PROCESS | 26543 | __start_cc_report 09:14:22 INFO - PROCESS | 26543 | _x_x_mozilla_cycle_collect,1953 09:14:22 INFO - PROCESS | 26543 | __end_cc_report 09:14:22 INFO - PROCESS | 26543 | __startTimestamp1471623262850__endTimestamp 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | ------- Summary: start ------- 09:14:22 INFO - PROCESS | 26543 | Number of tests: 14 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:3.34 (2.9%) stddev-sans-first:2.13 09:14:22 INFO - PROCESS | 26543 | Values: 107.0 113.0 115.0 117.0 114.0 115.0 118.0 115.0 119.0 113.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:137.50 stddev:25.49 (18.5%) stddev-sans-first:26.90 09:14:22 INFO - PROCESS | 26543 | Values: 147.0 120.0 125.0 199.0 123.0 123.0 149.0 121.0 163.0 128.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:14:22 INFO - PROCESS | 26543 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.85 (19.5%) stddev-sans-first:15.57 09:14:22 INFO - PROCESS | 26543 | Values: 76.0 76.0 77.0 119.0 78.0 76.0 75.0 75.0 99.0 73.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:86.00 stddev:20.80 (24.2%) stddev-sans-first:21.54 09:14:22 INFO - PROCESS | 26543 | Values: 86.0 85.0 129.0 86.0 86.0 87.0 124.0 85.0 86.0 133.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:14:22 INFO - PROCESS | 26543 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:14:22 INFO - PROCESS | 26543 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:14:22 INFO - PROCESS | 26543 | Values: 94.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 09:14:22 INFO - PROCESS | 26543 | Values: 63.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.00 stddev:3.21 (4.9%) stddev-sans-first:3.39 09:14:22 INFO - PROCESS | 26543 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 76.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 09:14:22 INFO - PROCESS | 26543 | Values: 83.0 81.0 82.0 83.0 83.0 82.0 82.0 83.0 82.0 82.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.50 stddev:9.41 (6.8%) stddev-sans-first:9.95 09:14:22 INFO - PROCESS | 26543 | Values: 137.0 147.0 141.0 134.0 140.0 136.0 132.0 132.0 162.0 131.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.50 stddev:3.24 (1.9%) stddev-sans-first:3.32 09:14:22 INFO - PROCESS | 26543 | Values: 171.0 176.0 171.0 171.0 178.0 178.0 171.0 174.0 175.0 169.0 09:14:22 INFO - PROCESS | 26543 | 09:14:22 INFO - PROCESS | 26543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.07 (3.0%) stddev-sans-first:2.19 09:14:22 INFO - PROCESS | 26543 | Values: 69.0 68.0 72.0 68.0 71.0 67.0 67.0 68.0 70.0 65.0 09:14:22 INFO - PROCESS | 26543 | -------- Summary: end -------- 09:14:22 INFO - PROCESS | 26543 | 09:14:23 INFO - TEST-INFO | 26543: exit 0 09:14:24 INFO - TEST-OK | kraken | took 63416ms 09:14:24 INFO - SUITE-END | took 1182s 09:14:24 INFO - Completed test suite (00:19:42) 09:14:24 INFO - javascript benchmark 09:14:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2517.144170981866, 2560.6287088372187, 2590.2876708905037, 2610.6475625790526, 2612.0, 4511.819527218916, 4599.310103484479, 4650.604698600619, 4656.952185758211, 4669.883252918675, 4613.8154473821005, 4656.697314674544, 4668.836590719326, 4742.027884283722, 4768.0, 4083.2241874043984, 4277.67917406195, 4366.410534577839, 4379.737215767048, 4419.646428285745, 4386.912261754763, 4407.603315701586, 4422.248217802965, 4428.512863585019, 4431.26884064129, 4202.138561594897, 4239.978800106011, 4248.490181178247, 4324.286492728712, 4324.8486302979245, 4229.619334259932, 4275.080857615628, 4283.079137985317, 4292.5492823253735, 4338.284183109783, 4272.786360681954, 4303.010307629263, 4309.181255561433, 4316.762578058206, 4316.892077698051, 4694.155052090622, 4698.624110071186, 4703.811847526129, 4712.222483290253, 4713.575778179946, 4788.7845046972625, 4939.135651261051, 4991.0, 4996.150654388763, 5054.545090941833, 5077.441481437039, 5083.872903177413, 5084.9745751271375, 5086.593072554224, 5092.465291144414, 4758.857234282942, 4759.928601070987, 4760.285957106462, 4767.022760334088, 4767.642426818003, 4957.776900039435, 5012.097822391932, 5016.347874776256, 5079.390473143247, 5116.181410974301, 4903.926441103386, 4940.703557786473, 4940.975295123501, 4943.3573635427165, 4949.282354058641, 4986.0277245936695, 4992.650514463952, 5001.44984051754, 5002.924956125661, 5004.999000199975, 4771.642126840501, 4896.559309662148, 4948.975255123702, 4952.356193694796, 5007.799688012512, 4978.10394129053, 4999.450060493343, 5003.799848006039, 5008.29883816266, 5009.173486374707, 4267.1892340455215, 4267.97866010668, 4271.67962402821, 4276.059266961263, 4280.101178752435, 3578.570571531433, 3640.635936406391, 3641.1079285574674, 3666.5233519642275, 3763.2285381496727, 4278.272693642089, 4315.244832154361, 4325.41606883073, 4333.609975102193, 4336.848210312624, 4998.325226094504, 5054.545090941833, 5061.519155680205, 5064.164412871834, 5065.442801291855, 4114.773687447159, 4230.027093768451, 4256.0, 4263.701540892108, 4300.139972005549, 4511.278195488706, 4522.706024108423, 4529.207388706963, 4533.773311334486, 4536.115457485758, 4758.405199350082, 4762.880927976828, 4764.4520880099235, 4773.1408346497965, 4779.569838714532, 4906.828261010847, 4953.356063711839, 4983.72589507566, 5009.348784657971, 5083.2883396323805, 4768.475467698481, 4775.283707443911, 4786.282057691375, 4788.688735232199, 4794.496577859274, 4969.577585905238, 4990.47600002009, 4994.300797888226, 5000.324956131021, 5000.924986125138, 4872.4153101628035, 4955.207166853286, 4979.327790748347, 4992.80028798844, 5058.772355244097, 4930.309756634146, 4939.036887806843, 4944.728039957837, 4946.332245147003, 4946.455889852042, 4906.043321552405, 4916.8770780730765, 4921.876953076058, 4923.4584195737725, 4927.655064145475, 4593.150267200445, 4707.411573553306, 4750.311204875343, 4764.071006153767, 4820.119803558169, 4900.068986892479, 4930.5069493050405, 4932.235503496964, 4935.506449355035, 4937.061958227925, 4780.856574302777, 4815.253635686474, 4824.614030877591, 4825.155597770306, 4827.106985207748], "value": 4596.135481931264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9469000444958, 567.1039757183651, 569.3424095170077, 569.4391024840533, 569.8945695046414, 28856.71143288569, 31663.525047124283, 39515.80242098793, 40685.18629627413, 40700.79649601755, 40971.795141024326, 41301.58698413023, 41310.17379652405, 41326.0, 41357.793211033975, 7553.169151393342, 7676.577788221645, 7690.884636730453, 7692.615369231544, 7699.499532530368, 7430.108386993568, 9554.713358599252, 9834.655787047455, 9836.803263934717, 10189.694309170736, 9985.850212246822, 10065.446400447972, 10072.294939354248, 10077.44574048427, 10078.949605252, 10066.69799906004, 10130.797384052277, 10140.543675534618, 10140.746481337952, 10144.239182061301, 9961.850572241423, 10016.0, 10019.499025048792, 10027.699169024942, 10042.246831487595, 38333.42499862504, 38647.22705545873, 38678.419823702665, 38730.61269387298, 38741.80629096865, 2846.6157068795656, 2993.790434669574, 2997.460457117718, 2998.880044798227, 3149.322895577439, 29067.82325725328, 29366.41267174666, 29400.0, 29536.261593460335, 29640.8517957411, 2881.5101432756483, 3133.6239651241767, 3236.1689470553288, 3250.1062207892783, 3302.3725492156655, 245823.0, 245957.0, 246025.0, 246748.0, 246774.76612617003, 31211.219719507193, 52087.958240834974, 52559.21161182586, 52593.7370313146, 52680.20979685308, 32042.839785800923, 33649.15877103043, 33748.156296092304, 33771.49342759861, 33790.155246119044, 12137.089718270989, 12202.267863928193, 12214.572489962986, 12269.0, 12272.079594030483, 9237.769055773659, 9695.51522423876, 9853.16248118918, 9927.156191723785, 9945.801083978424, 7745.380369570421, 7783.766487005286, 7877.684892604231, 7883.132855385903, 7901.683932642745, 2845.2886778305424, 2965.3772707731187, 3061.2040869374123, 3091.2890035292007, 3108.751299896003, 815.6288888555812, 854.9914500854912, 856.1139220906457, 890.5636238243214, 930.8557173638097, 27123.0, 28368.432631347256, 28471.43057138887, 28708.0, 28987.275318117216, 911.1389736698889, 914.1772404835701, 928.6053427293373, 941.0967166292065, 994.786120983992, 14773.92613036928, 14900.329485173193, 14932.850671493363, 15009.849901500846, 15197.468088617066, 359813.0, 364092.0, 364369.0, 364940.0, 365030.0, 49828.75085624621, 50344.0, 50354.49645503571, 50407.74796126069, 50473.49526504761, 1080.5191689698165, 1097.7859317433183, 1109.9611513596985, 1155.1163360029584, 1173.3194747046693, 20192.59614807725, 31177.220569485944, 31327.84336078305, 31458.84270578724, 32093.518597220595, 46267.0, 46590.53409465862, 46604.30093548667, 46697.29954050624, 47017.2947405796, 316339.0, 319937.0, 321128.0, 321372.0, 321737.0, 25057.123000695618, 25544.61683074718, 25854.224373268833, 25942.22173334803, 25948.870255648602, 41441.58558414498, 42120.36819447772, 42895.78552107344, 42906.1418771629, 42911.570884290755, 35782.0, 35959.64040359563, 37130.8143459281, 37781.0, 37917.62082379141, 35423.0, 35838.820805895804, 36207.275854482235, 36373.0, 36640.63359366479, 35437.29125417529, 35446.64553354433, 36096.81951590225, 36170.0, 36575.45136823003, 30988.0, 33002.0, 33145.50281745824, 33211.50182747212, 33329.0, 23906.40233994164, 24413.51172976566, 24487.877560612083, 24863.37841553903, 24928.626070608592], "value": 16668.19524854416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.8785924926278, 354.49838478552863, 362.78414343465647, 366.60589865894167, 392.55052964355815, 13202.867971320284, 15970.84029159708, 16485.999999999985, 18004.639907201847, 18164.091795410244, 15514.30185641646, 15760.369585216578, 15833.287502062407, 15954.28205730742, 16084.919575402108, 4926.236433352827, 5123.666961647499, 5237.79048838046, 5399.946000540003, 5470.5350045246205, 3477.2523907359914, 5242.947570524284, 5495.945040549604, 5530.364008139055, 5539.667619942797, 5435.945640543583, 5438.374586922515, 5450.618456708032, 5507.917381239265, 5533.474319939599, 5478.424765399615, 5484.162805460176, 5511.283533140706, 5962.135490353874, 5996.370381109964, 5301.893962120736, 5304.708241046741, 5307.363116426015, 5307.628466007381, 5312.814051508218, 12273.754524909451, 17374.47876563705, 19410.4176874694, 20079.196832126698, 20170.495737606532, 1759.5777013516793, 1848.1960347248855, 1883.9811601883944, 1900.064400501215, 1919.4145785535407, 9548.283878709055, 9591.904080959172, 10821.621243256448, 12267.018638508987, 13414.396352164078, 1719.1662043908693, 1744.5551384396897, 1783.9197236124405, 1786.97319540207, 1796.9011704356255, 66760.66619666871, 67603.0, 67720.6613966927, 68131.0, 68801.31198687998, 8053.15441878606, 8452.070272270046, 8546.487210767375, 8548.102449242864, 8802.647894084164, 11342.432878356049, 11493.195476316745, 11494.195406321645, 11509.309441433541, 11523.711907202387, 6400.199975003125, 6542.934570654328, 6587.0, 6734.865302693918, 6738.090357801634, 6511.088447617338, 6541.2150541934325, 6679.398854103154, 6692.330766923366, 6714.462842972648, 3652.8493524539685, 3698.4082546792924, 3701.426278926717, 3747.6439738224826, 3826.6364695353896, 1775.6448710258, 1782.10003948008, 1785.0806834480254, 1824.6441943821094, 1827.954301142482, 779.6608475313257, 790.1348023913805, 875.4003507597316, 888.1163242573681, 906.8639704044446, 16665.666686666198, 16719.83280167207, 16763.664726705396, 16922.661546769243, 17734.733978990327, 838.2455789789117, 842.3640151685561, 848.809017970964, 891.5809569502323, 905.2215095018279, 9303.395279306824, 9720.368176068532, 9754.902450975542, 9822.73783754126, 9834.950825245827, 363069.0, 371606.38856257126, 376176.5955851126, 378517.0, 381096.0, 62991.685041575416, 72973.63513182507, 74211.0, 74991.62504187445, 79133.60433197797, 900.8603666431583, 906.4878343735768, 942.707760594218, 944.0559440559441, 951.7620594851287, 15679.68640627204, 15719.371225151323, 16469.670606587562, 16513.174341283127, 16745.413910513074, 36705.265894681426, 36856.44715329326, 37723.622763773106, 37936.0, 38486.80756596199, 50431.0, 50536.0, 52016.479835201164, 52921.7353913228, 53536.73231633973, 7278.199398066103, 7369.968204451488, 7487.700491980478, 7489.70041198346, 7732.574708391093, 8455.788605284917, 10664.200184986003, 10787.838182427427, 10958.726031849268, 11962.222455540363, 9753.219742420732, 9895.901040989498, 10190.643327483502, 10451.94774026125, 10726.302790318605, 9970.950145249228, 10087.0, 10090.545925433225, 10203.795924081625, 10211.387316761018, 9590.66432674853, 10100.747481313027, 10104.545295461869, 10174.694759157237, 10719.89280107189, 7020.508564400443, 7088.645567721696, 7166.426685865014, 7217.67520461591, 7309.853802924018, 8967.910320896708, 9893.25800564946, 10180.541875615467, 10258.794824103326, 10279.486025698834], "value": 7980.580273316848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.4227582139679, 1393.714288570843, 1424.8147740793695, 1633.126277441569, 1646.7365221564553, 7186.8203294917585, 7689.923100768998, 7703.961480192605, 7709.884351734729, 7712.0745510538745, 6655.567388119769, 6871.931280687191, 6872.037914691935, 7075.929240707592, 7543.094828620573, 1880.219708820841, 2123.851330406872, 2191.627423338028, 2198.0658220256405, 2205.6250437425674, 2140.176032227588, 2167.6098302305577, 2175.5431359414542, 2179.9891000544976, 2181.1929586053184, 2174.4455163933176, 2178.891055447229, 2180.4221881201493, 2181.0839447432118, 2182.8035476807086, 2107.6417009108486, 2109.9766613192587, 2150.924717634891, 2154.2460138951396, 2157.4390658428765, 2099.1078791513546, 2117.68234764785, 2124.8618839775363, 2125.744910610721, 2129.968050479244, 7565.0, 7696.692132314756, 7698.0, 7704.922950770532, 7728.381729461629, 4302.913941721179, 4435.62297204738, 4441.156180325728, 4450.176717307276, 4451.0, 2727.890884364623, 2878.2372671242138, 2889.5376739721755, 2914.1403286030672, 2940.6618238902374, 905.7056456651615, 910.4082346474778, 922.2437601167046, 950.4154944708954, 959.3572306554626, 10467.947660261727, 10468.790624187473, 10474.21443391741, 10475.633352832614, 10483.947580262049, 3882.417637354363, 4193.193755649488, 4238.3430568261965, 4313.158934007901, 4332.740035597874, 9139.81720365589, 9165.0, 9179.495127768037, 9181.311401644904, 9182.724518264462, 4420.7126536775, 4421.734695918255, 4425.645948324191, 4426.026274219666, 4435.556444355603, 3950.288947989332, 3971.5829837867186, 3990.2219067281603, 3994.1612261425425, 4002.8799136025964, 3641.599424063351, 3642.653947874948, 3722.9441558376648, 3765.5293088363956, 3765.9058523536582, 1216.3614102596032, 1217.1601594899491, 1233.4326209943526, 1241.422738426636, 1248.2399816259212, 704.2886684448744, 752.2627824731793, 791.2285521616493, 802.7872613757359, 817.1817705604981, 5010.674306170087, 5057.671251368649, 5074.13739664258, 5104.872378190575, 5327.573794096541, 398.82252397682754, 399.3430806323581, 407.4377359244224, 418.7257346438088, 422.8815931539174, 3383.3233353329433, 3428.9485657715154, 3437.3812713711773, 3441.5353927219503, 3541.911452213715, 9075.636974521078, 9547.0, 9563.234941204826, 9579.425234485952, 9594.712158635251, 9518.762030949281, 9527.571259293349, 9531.189848862785, 9536.094071063239, 9536.570854311572, 7012.088428504262, 7101.041359416516, 7108.644567771694, 7121.109861267341, 7122.60825654594, 4973.104841128632, 5019.7490125494305, 5038.244263360525, 5063.797448102035, 5202.271681964452, 8464.830703385775, 8684.001339845998, 8738.34462415334, 8872.467651940904, 8945.73162805117, 8395.95802020986, 8617.353698472514, 8687.956560217159, 8977.551122443982, 9002.639894404412, 6510.251321098134, 6707.5304728668525, 6776.051352810709, 6782.626955517494, 6788.626625535643, 7415.8887616684715, 7489.0, 7489.887651685338, 7494.475386722877, 7505.399568034435, 6445.419912207736, 6488.188976377953, 6522.739090436329, 6537.542372034102, 6672.8999065013095, 6499.480041596756, 6518.315576864361, 6629.0, 6644.634545100066, 6751.291114432914, 6027.517798576191, 6063.060225664853, 6094.268687757498, 6113.57204995646, 6128.938710612837, 4485.416895803524, 4493.662975276802, 4527.547245275446, 4544.477385100756, 4554.407926969473, 4436.82252709888, 4437.733735975852, 4547.795349209227, 4586.220342541709, 4687.624990000723], "value": 3980.357505406642, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.403221380064, 293.39121323254244, 302.75628119363904, 302.82436187011524, 305.5783019433182, 4839.830605928793, 4848.709077455355, 4883.632582876796, 4887.486813884544, 4906.190478571036, 4736.573708366246, 4795.880102997427, 4818.951810481894, 4833.347498087757, 4859.854204373865, 3799.601041890603, 3808.1812410331772, 3820.4842346283244, 3826.6364695353896, 3838.2323535292912, 3569.2147727500037, 3643.3988391915304, 3857.1514266861245, 3863.343231650612, 3863.690904727615, 3228.6771322867644, 3629.8366573504254, 3637.94543081854, 3643.071016890689, 3723.2925744108534, 3658.4878117063768, 3717.126475278307, 3725.1432170600915, 3737.5701794293595, 3752.418375151856, 3306.2230375861895, 3307.7023067924, 3308.520264561649, 3308.669133086696, 3316.5688460500223, 4479.686421950465, 4504.752238626874, 4650.25595904657, 4651.5813576778255, 4686.95313046872, 4242.0, 4247.532771395144, 4252.298370768819, 4256.701705979675, 4261.722988005769, 4975.278584605248, 4985.5513003829465, 4986.152354099811, 4997.250412438127, 5006.774695138691, 3562.6793588576893, 3643.4352675335367, 3651.6713495785507, 3657.579378371495, 3669.4679271505747, 5167.638265321467, 5185.403678576974, 5193.766280517386, 5204.583633309327, 5207.60942929278, 3708.1100535871196, 3711.2020915503294, 3715.405535114369, 3755.2114056048536, 3768.378217594121, 3801.258754542893, 3805.486259355007, 3809.5047643806683, 3816.6183381661613, 3818.7326887118193, 4188.162367526507, 4267.8719638410275, 4291.120320334324, 4301.505326887385, 4318.589733975267, 4968.484612193316, 4984.0, 4986.501349864984, 4986.825461108916, 4989.0, 1301.7958388490797, 1321.1346567997978, 1322.821419108408, 1324.3510679766846, 1325.7812460944028, 826.7519744076753, 858.0089996054567, 869.4956924983494, 886.7251152142857, 886.7694399456059, 3947.50656167979, 3962.445257663929, 3971.7091945117954, 3973.6225058619384, 3979.5525751662517, 4541.114482675913, 4546.863284178955, 4561.722717639066, 4581.633469322446, 4587.8623641290815, 3955.20895820837, 3979.4826672532386, 3986.5216174059296, 4007.979960100181, 4019.8593049243723, 2297.8391512593957, 2425.7210420801835, 2430.5989511730368, 2433.7322894481595, 2485.3662316109276, 4316.719413238129, 4323.308270676676, 4328.956710432855, 4335.393044973706, 4339.134172305876, 4667.579917807414, 4679.549339704702, 4976.303317535548, 5012.298278241049, 5234.450382709837, 4844.273358996179, 4854.78153483087, 4861.416630004422, 4869.561739443467, 4882.780274887638, 5104.642675012714, 5124.128898087409, 5148.150555158357, 5152.5877929766275, 5159.17453207485, 4808.486845686046, 5041.470645582308, 5046.57104146137, 5049.2173713074535, 5082.2122571001555, 4884.682495637772, 4905.926411103907, 4910.582600479, 4910.993246384412, 4927.1377508935075, 3737.9065523362133, 3742.6070262622034, 3743.1016556026902, 3744.9438258425603, 3750.2499500099543, 4881.9023619528125, 5121.129408000724, 5154.943236636405, 5186.4035635902355, 5186.4294927557185, 4979.178435558092, 5002.324686167321, 5005.34930459038, 5007.824726134568, 5008.173651347487, 5006.249062640633, 5007.474215207497, 5013.774380152829, 5014.824481143289, 5016.2224855147515, 4688.531146885284, 4912.1158191525865, 4935.0, 4948.851534453972, 4951.801927922843, 5039.924401133912, 5052.964142350883, 5057.342545469065, 5061.0, 5066.5693416058575, 4943.678660887174, 4984.800607975641, 4986.6010719143105, 4991.850244492671, 5036.294918711456], "value": 3729.496161698947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.257334764913, 622.1321256846699, 625.6089943785134, 633.8352028472597, 719.1442183801279, 12745.553905613306, 12751.681207969794, 12846.614601561945, 12991.545295914644, 13272.46910123595, 13165.934170329136, 13335.199888006702, 13343.1994080355, 13353.53262635808, 13356.198628082298, 618.5546406587273, 754.4869488747636, 776.6737970052563, 780.2314720000795, 780.4575819805237, 751.8458715963214, 775.9456838021341, 777.3586790897504, 786.3748320085546, 787.1027029186703, 820.5486982159788, 822.8230930349973, 823.7487566292278, 823.9423240373176, 824.1881746479713, 652.3052948609716, 822.4489591973393, 822.7984143884727, 823.3043078598574, 823.5593957232882, 569.6126633888954, 584.9824505264849, 585.9267591551056, 587.2219309415042, 587.6209844650219, 11509.76980460386, 11532.481038353295, 11856.22934509254, 11887.0, 11985.760284794342, 12489.75020499594, 12884.80672789909, 13300.667483312898, 13420.731585368336, 13510.392032358568, 11890.821637675443, 12001.879981200163, 12202.633920982385, 12520.436580353906, 12592.0, 3322.1362445764034, 3460.740444466675, 4228.238916994939, 4269.829206831723, 4343.6959412841115, 57764.13353799696, 58260.70869645667, 58712.70643646797, 59298.99999999957, 59868.70065649644, 10542.262041657164, 10820.56717731282, 10877.292975956538, 10939.56241750321, 11395.25930814511, 18885.622287554448, 18918.148683309286, 18937.242510299708, 18942.715859262124, 18943.0, 6892.689828957709, 6959.6868140933775, 7083.362497375261, 7180.928190718026, 7195.92804071963, 3612.4942508048894, 3660.5973342932257, 3716.2567486502808, 3739.513863197821, 3807.2195199983935, 2997.520396736512, 3085.799423037495, 3112.9533057004164, 3113.377324535102, 3115.922101947424, 506.8403452912321, 507.14545990006957, 510.67316917173036, 512.1038183179436, 519.1693290734794, 532.2761044978826, 536.5010540197576, 538.3405328472589, 541.8049502179213, 559.9132134519156, 7765.378769698411, 7927.326177274881, 8103.149169337253, 8379.832403351898, 8740.169683880022, 510.20917577754335, 519.7713006277302, 575.9882418952019, 576.6626523483725, 603.6830663901399, 3961.80505451089, 4128.401381799622, 4140.330588399507, 4143.668506519532, 4256.893577660521, 76983.61508192535, 80287.0, 80725.0, 83951.0, 98660.0, 78368.60815695886, 78490.21509784943, 78979.0, 79690.6402167726, 83471.5826420864, 43210.351844722354, 43380.78309608432, 43557.564424355354, 44007.0, 67630.99999999901, 8291.33669306442, 8364.289035431813, 8540.786480338042, 8674.566271686264, 9281.39670921388, 42508.14983700247, 42747.57252427436, 43324.56675433331, 43458.782706087535, 43994.0, 51794.0, 53595.732021339645, 54376.0, 59230.703846480494, 59981.70009149926, 10271.794564108826, 10293.794124117625, 10362.896371036193, 11771.117166212398, 11914.404279785802, 12793.168444051107, 13259.734805304033, 13567.457301708217, 13765.449382024606, 13814.37835297394, 10824.56701731922, 11586.188966772583, 11629.459836555441, 11661.825072623747, 12003.939980300043, 11720.765584688088, 11782.293062416282, 11845.111616628616, 12076.33580153065, 12650.05124615639, 11675.941620291844, 12192.878071219175, 12496.937515312366, 12509.061095530207, 12528.123031387715, 9092.227160691415, 9359.204467620328, 9432.62269509212, 9781.706548803548, 9907.851382229128, 8877.955610221907, 9069.77325566866, 9459.337846350689, 9627.597647564291, 9786.168175705145], "value": 6448.907126854089, "unit": "score"}], "name": "dromaeo_css", "value": 6231.185089775955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 115.0, 117.0, 114.0, 115.0, 118.0, 115.0, 119.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 125.0, 199.0, 123.0, 123.0, 149.0, 121.0, 163.0, 128.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 119.0, 78.0, 76.0, 75.0, 75.0, 99.0, 73.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 129.0, 86.0, 86.0, 87.0, 124.0, 85.0, 86.0, 133.0], "value": 98.7, "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, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 76.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 83.0, 83.0, 82.0, 82.0, 83.0, 82.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 147.0, 141.0, 134.0, 140.0, 136.0, 132.0, 132.0, 162.0, 131.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 171.0, 171.0, 178.0, 178.0, 171.0, 174.0, 175.0, 169.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 68.0, 71.0, 67.0, 67.0, 68.0, 70.0, 65.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1549.9, "alertThreshold": 2.0}]} 09:14:24 INFO - Return code: 0 09:14:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:24 INFO - # TBPL SUCCESS # 09:14:24 INFO - Running post-action listener: _resource_record_post_action 09:14:24 INFO - [mozharness: 2016-08-19 16:14:24.126312Z] Finished run-tests step (success) 09:14:24 INFO - Running post-run listener: _resource_record_post_run 09:14:24 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 407363584; Read time: 0; Write time: 319812 09:14:24 INFO - TinderboxPrint: CPU usage
13.0% 09:14:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:14:24 INFO - TinderboxPrint: I/O write bytes / time
407,363,584 / 319,812 09:14:24 INFO - TinderboxPrint: CPU idle
8,324.9 (87.0%) 09:14:24 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 09:14:24 INFO - TinderboxPrint: Swap in / out
0 / 0 09:14:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124809216; Read time: 0; Write time: 97044 09:14:24 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 281518080; Read time: 0; Write time: 222736 09:14:24 INFO - Running post-run listener: _upload_blobber_files 09:14:24 INFO - Blob upload gear active. 09:14:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:24 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 09:14:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:25 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:26 INFO - (blobuploader) - INFO - Done attempting. 09:14:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:26 INFO - (blobuploader) - INFO - Done attempting. 09:14:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:32 INFO - (blobuploader) - INFO - Done attempting. 09:14:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:32 INFO - Return code: 0 09:14:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acb543a751411a72a34cd3c999bad096778115180544ff4ddf89cb931e10f6b3cf2b8f9e2ac7c039e9b73cf42235799787c39bbfd5aba34f6a46ed631493405a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10e6bf07ea1495d379fa6d4d57667c2b3c9b882eee4222c4d23ede5a52aca3480558b213efb4b7bb9a7c107b46da7ed28f3aef2734997763289d8cfe7fb11d56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a0285c17e95b21442a2bd0d60a10d1c0b6dd0ed7950d6837897ff39606905db8daad93f6c3fd4a1b0edbd4ba8c630b46b4766505a3f478d5e67253b7f7d451c"} 09:14:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:32 INFO - Contents: 09:14:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acb543a751411a72a34cd3c999bad096778115180544ff4ddf89cb931e10f6b3cf2b8f9e2ac7c039e9b73cf42235799787c39bbfd5aba34f6a46ed631493405a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10e6bf07ea1495d379fa6d4d57667c2b3c9b882eee4222c4d23ede5a52aca3480558b213efb4b7bb9a7c107b46da7ed28f3aef2734997763289d8cfe7fb11d56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a0285c17e95b21442a2bd0d60a10d1c0b6dd0ed7950d6837897ff39606905db8daad93f6c3fd4a1b0edbd4ba8c630b46b4766505a3f478d5e67253b7f7d451c"} 09:14:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:32 INFO - Copying logs to upload dir... 09:14:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.752196 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-19 09:14:31.661337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 09:14:31.664490) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acb543a751411a72a34cd3c999bad096778115180544ff4ddf89cb931e10f6b3cf2b8f9e2ac7c039e9b73cf42235799787c39bbfd5aba34f6a46ed631493405a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10e6bf07ea1495d379fa6d4d57667c2b3c9b882eee4222c4d23ede5a52aca3480558b213efb4b7bb9a7c107b46da7ed28f3aef2734997763289d8cfe7fb11d56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a0285c17e95b21442a2bd0d60a10d1c0b6dd0ed7950d6837897ff39606905db8daad93f6c3fd4a1b0edbd4ba8c630b46b4766505a3f478d5e67253b7f7d451c"} build_url:https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/X8Y0R9azQEG49BmnUbN8WA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acb543a751411a72a34cd3c999bad096778115180544ff4ddf89cb931e10f6b3cf2b8f9e2ac7c039e9b73cf42235799787c39bbfd5aba34f6a46ed631493405a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10e6bf07ea1495d379fa6d4d57667c2b3c9b882eee4222c4d23ede5a52aca3480558b213efb4b7bb9a7c107b46da7ed28f3aef2734997763289d8cfe7fb11d56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a0285c17e95b21442a2bd0d60a10d1c0b6dd0ed7950d6837897ff39606905db8daad93f6c3fd4a1b0edbd4ba8c630b46b4766505a3f478d5e67253b7f7d451c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 09:14:31.694440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 09:14:31.694783) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471621880.746415-1159683584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 09:14:31.780682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 09:14:31.781290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 09:14:31.781877) ========= ========= Total master_lag: 0.21 =========