builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1472667208.83 results: success (0) buildid: 20160831083037 builduid: 7408cd8b0e2e49f1a89e42ebfb8a12be revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:28.828882) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:28.829307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:28.829619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:28.858080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:28.858480) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 11:13:31-- 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% 207M=0s 2016-08-31 11:13:31 (207 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.375405 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:29.347979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:29.348590) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013662 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:29.380970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:29.381337) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51afefd5f63d13b28b304c52301818cfad7d229b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 51afefd5f63d13b28b304c52301818cfad7d229b --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=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 11:13:31,980 truncating revision to first 12 chars 2016-08-31 11:13:31,980 Setting DEBUG logging. 2016-08-31 11:13:31,980 attempt 1/10 2016-08-31 11:13:31,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51afefd5f63d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 11:13:32,274 unpacking tar archive at: fx-team-51afefd5f63d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614059 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:30.013266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:30.013573) ========= script_repo_revision: 51afefd5f63d13b28b304c52301818cfad7d229b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:30.014018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:30.014346) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 11:13:30.025140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-31 11:13:30.025719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:32 INFO - MultiFileLogger online at 20160831 11:13:32 in /builds/slave/test 11:13:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:13:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:13:32 INFO - {'append_to_log': False, 11:13:32 INFO - 'base_work_dir': '/builds/slave/test', 11:13:32 INFO - 'blob_upload_branch': 'Fx-Team', 11:13:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:13:32 INFO - 'branch': 'Fx-Team', 11:13:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:32 INFO - 'config_files': ('talos/linux_config.py',), 11:13:32 INFO - 'default_actions': ('clobber', 11:13:32 INFO - 'read-buildbot-config', 11:13:32 INFO - 'download-and-extract', 11:13:32 INFO - 'populate-webroot', 11:13:32 INFO - 'create-virtualenv', 11:13:32 INFO - 'install', 11:13:32 INFO - 'run-tests'), 11:13:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:32 INFO - 'download_minidump_stackwalk': True, 11:13:32 INFO - 'download_symbols': 'ondemand', 11:13:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:13:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:13:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:13:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:13:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:32 INFO - 'installer_path': 'installer.exe', 11:13:32 INFO - 'log_level': 'info', 11:13:32 INFO - 'log_name': 'talos', 11:13:32 INFO - 'log_to_console': True, 11:13:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:32 INFO - 'opt_config_files': (), 11:13:32 INFO - 'pip_index': False, 11:13:32 INFO - 'sps_profile': False, 11:13:32 INFO - 'sps_profile_interval': 0, 11:13:32 INFO - 'suite': 'dromaeojs', 11:13:32 INFO - 'system_bits': '32', 11:13:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:32 INFO - 'title': 'talos-linux64-ix-064', 11:13:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:32 INFO - 'use_talos_json': True, 11:13:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:13:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:32 INFO - 'work_dir': 'build'} 11:13:32 INFO - [mozharness: 2016-08-31 18:13:32.717330Z] Running clobber step. 11:13:32 INFO - Running pre-action listener: _resource_record_pre_action 11:13:32 INFO - Running main action method: clobber 11:13:32 INFO - rmtree: /builds/slave/test/build 11:13:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:13:33 INFO - Running post-action listener: _resource_record_post_action 11:13:33 INFO - [mozharness: 2016-08-31 18:13:33.673287Z] Finished clobber step (success) 11:13:33 INFO - [mozharness: 2016-08-31 18:13:33.673388Z] Running read-buildbot-config step. 11:13:33 INFO - Running pre-action listener: _resource_record_pre_action 11:13:33 INFO - Running main action method: read_buildbot_config 11:13:33 INFO - Using buildbot properties: 11:13:33 INFO - { 11:13:33 INFO - "project": "", 11:13:33 INFO - "product": "firefox", 11:13:33 INFO - "script_repo_revision": "production", 11:13:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:13:33 INFO - "repository": "", 11:13:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:13:33 INFO - "buildid": "20160831083037", 11:13:33 INFO - "pgo_build": "True", 11:13:33 INFO - "basedir": "/builds/slave/test", 11:13:33 INFO - "buildnumber": 1509, 11:13:33 INFO - "slavename": "talos-linux64-ix-064", 11:13:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:13:33 INFO - "platform": "ubuntu64_hw", 11:13:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:13:33 INFO - "branch": "fx-team", 11:13:33 INFO - "repo_path": "integration/fx-team", 11:13:33 INFO - "revision": "51afefd5f63d13b28b304c52301818cfad7d229b", 11:13:33 INFO - "stage_platform": "linux64-pgo", 11:13:33 INFO - "builduid": "7408cd8b0e2e49f1a89e42ebfb8a12be", 11:13:33 INFO - "slavebuilddir": "test" 11:13:33 INFO - } 11:13:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:13:33 INFO - Running post-action listener: _resource_record_post_action 11:13:33 INFO - [mozharness: 2016-08-31 18:13:33.675828Z] Finished read-buildbot-config step (success) 11:13:33 INFO - [mozharness: 2016-08-31 18:13:33.675916Z] Running download-and-extract step. 11:13:33 INFO - Running pre-action listener: _resource_record_pre_action 11:13:33 INFO - Running main action method: download_and_extract 11:13:33 INFO - mkdir: /builds/slave/test/build/tests 11:13:33 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')]} 11:13:33 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:13:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:34 INFO - Downloaded 1361 bytes. 11:13:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:13:34 INFO - Using the following test package requirements: 11:13:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:13:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:13:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'jsshell-linux-x86_64.zip'], 11:13:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:13:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:13:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:13:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:13:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:13:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:34 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:13:34 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:35 INFO - Downloaded 21903642 bytes. 11:13:35 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 11:13:39 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 11:13:39 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')]} 11:13:39 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:13:39 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:40 INFO - Downloaded 21903642 bytes. 11:13:40 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 11:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:44 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:45 INFO - Downloaded 14413998 bytes. 11:13:45 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 11:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:45 INFO - trying https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:13:45 INFO - Downloading https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/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 11:13:47 INFO - Downloaded 59743264 bytes. 11:13:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:13:47 INFO - mkdir: /builds/slave/test/properties 11:13:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:47 INFO - Contents: 11:13:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:13:47 INFO - Running post-action listener: _resource_record_post_action 11:13:47 INFO - Running post-action listener: set_extra_try_arguments 11:13:47 INFO - [mozharness: 2016-08-31 18:13:47.714836Z] Finished download-and-extract step (success) 11:13:47 INFO - [mozharness: 2016-08-31 18:13:47.715064Z] Running populate-webroot step. 11:13:47 INFO - Running pre-action listener: _resource_record_pre_action 11:13:47 INFO - Running main action method: populate_webroot 11:13:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:47 INFO - '--tppagecycles', 11:13:47 INFO - '7'], 11:13:47 INFO - 'tests': ['tsvgm']}}, 11:13:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['damp', 'tps']}, 11:13:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'tests': ['damp', 'tps']}, 11:13:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['dromaeo_dom']}, 11:13:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['basic_compositor_video']}, 11:13:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:13:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['a11yr', 11:13:47 INFO - 'ts_paint', 11:13:47 INFO - 'tpaint', 11:13:47 INFO - 'sessionrestore', 11:13:47 INFO - 'sessionrestore_no_auto_restore', 11:13:47 INFO - 'tabpaint']}, 11:13:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['tsvgx', 11:13:47 INFO - 'tsvgr_opacity', 11:13:47 INFO - 'tart', 11:13:47 INFO - 'tscrollx', 11:13:47 INFO - 'cart']}, 11:13:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:47 INFO - 'tsvgr_opacity', 11:13:47 INFO - 'tart', 11:13:47 INFO - 'tscrollx', 11:13:47 INFO - 'cart']}, 11:13:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'talos_options': ['--disable-e10s'], 11:13:47 INFO - 'tests': ['tp5o']}, 11:13:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'tests': ['tp5o']}, 11:13:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'talos_options': ['--disable-e10s', 11:13:47 INFO - '--xperf_path', 11:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:47 INFO - 'tests': ['tp5n']}, 11:13:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:47 INFO - 'talos_options': ['--xperf_path', 11:13:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:47 INFO - 'tests': ['tp5n']}}, 11:13:47 INFO - 'talos.zip': {'path': '', 11:13:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:47 INFO - Running post-action listener: _resource_record_post_action 11:13:47 INFO - [mozharness: 2016-08-31 18:13:47.736170Z] Finished populate-webroot step (success) 11:13:47 INFO - [mozharness: 2016-08-31 18:13:47.736259Z] Running create-virtualenv step. 11:13:47 INFO - Running pre-action listener: _resource_record_pre_action 11:13:47 INFO - Running main action method: create_virtualenv 11:13:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:47 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 11:13:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:13:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:47 INFO - Using real prefix '/usr' 11:13:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:50 INFO - Installing pip.................done. 11:13:50 INFO - Return code: 0 11:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:50 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')]} 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:50 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')]} 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:50 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:50 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 11:13:50 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 11:13:50 INFO - Using env: {'DISPLAY': ':0', 11:13:50 INFO - 'HOME': '/home/cltbld', 11:13:50 INFO - 'LANG': 'en_US.UTF-8', 11:13:50 INFO - 'LANGUAGE': 'en_US:en', 11:13:50 INFO - 'LOGNAME': 'cltbld', 11:13:50 INFO - 'MAIL': '/var/mail/cltbld', 11:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:50 INFO - 'MOZ_NO_REMOTE': '1', 11:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:50 INFO - 'NO_EM_RESTART': '1', 11:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:50 INFO - 'PWD': '/builds/slave/test', 11:13:50 INFO - 'SHELL': '/bin/bash', 11:13:50 INFO - 'SHLVL': '1', 11:13:50 INFO - 'TERM': 'linux', 11:13:50 INFO - 'TMOUT': '86400', 11:13:50 INFO - 'USER': 'cltbld', 11:13:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:50 INFO - '_': '/tools/buildbot/bin/python'} 11:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:50 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 11:13:50 INFO - Cleaning up... 11:13:50 INFO - Return code: 0 11:13:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:50 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')]} 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:50 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')]} 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:50 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:50 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 11:13:50 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 11:13:50 INFO - Using env: {'DISPLAY': ':0', 11:13:50 INFO - 'HOME': '/home/cltbld', 11:13:50 INFO - 'LANG': 'en_US.UTF-8', 11:13:50 INFO - 'LANGUAGE': 'en_US:en', 11:13:50 INFO - 'LOGNAME': 'cltbld', 11:13:50 INFO - 'MAIL': '/var/mail/cltbld', 11:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:50 INFO - 'MOZ_NO_REMOTE': '1', 11:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:50 INFO - 'NO_EM_RESTART': '1', 11:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:50 INFO - 'PWD': '/builds/slave/test', 11:13:50 INFO - 'SHELL': '/bin/bash', 11:13:50 INFO - 'SHLVL': '1', 11:13:50 INFO - 'TERM': 'linux', 11:13:50 INFO - 'TMOUT': '86400', 11:13:50 INFO - 'USER': 'cltbld', 11:13:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:50 INFO - '_': '/tools/buildbot/bin/python'} 11:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:50 INFO - Downloading/unpacking psutil>=3.1.1 11:13:50 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 11:13:50 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 11:13:50 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 11:13:50 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 11:13:50 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 11:13:50 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 11:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:52 INFO - Installing collected packages: psutil 11:13:52 INFO - Running setup.py install for psutil 11:13:52 INFO - building 'psutil._psutil_linux' extension 11:13:52 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 11:13:52 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 11:13:53 INFO - building 'psutil._psutil_posix' extension 11:13:53 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 11:13:53 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 11:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:53 INFO - Successfully installed psutil 11:13:53 INFO - Cleaning up... 11:13:53 INFO - Return code: 0 11:13:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:53 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 11:13:53 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 11:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:53 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 11:13:53 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 11:13:53 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 11:13:53 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 11:13:53 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 11:13:53 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 11:13:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:55 INFO - Installing collected packages: mozsystemmonitor 11:13:55 INFO - Running setup.py install for mozsystemmonitor 11:13:55 INFO - Successfully installed mozsystemmonitor 11:13:55 INFO - Cleaning up... 11:13:55 INFO - Return code: 0 11:13:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:13:55 INFO - Using env: {'DISPLAY': ':0', 11:13:55 INFO - 'HOME': '/home/cltbld', 11:13:55 INFO - 'LANG': 'en_US.UTF-8', 11:13:55 INFO - 'LANGUAGE': 'en_US:en', 11:13:55 INFO - 'LOGNAME': 'cltbld', 11:13:55 INFO - 'MAIL': '/var/mail/cltbld', 11:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:55 INFO - 'MOZ_NO_REMOTE': '1', 11:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:55 INFO - 'NO_EM_RESTART': '1', 11:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:55 INFO - 'PWD': '/builds/slave/test', 11:13:55 INFO - 'SHELL': '/bin/bash', 11:13:55 INFO - 'SHLVL': '1', 11:13:55 INFO - 'TERM': 'linux', 11:13:55 INFO - 'TMOUT': '86400', 11:13:55 INFO - 'USER': 'cltbld', 11:13:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:55 INFO - '_': '/tools/buildbot/bin/python'} 11:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:57 INFO - warning: no files found matching '*.txt' 11:13:57 INFO - no previously-included directories found matching 'build' 11:13:57 INFO - no previously-included directories found matching 'dist' 11:13:57 INFO - no previously-included directories found matching '.git*' 11:13:57 INFO - Installing collected packages: jsonschema, functools32 11:13:58 INFO - Running setup.py install for functools32 11:13:58 INFO - warning: no files found matching '*.txt' 11:13:58 INFO - no previously-included directories found matching 'build' 11:13:58 INFO - no previously-included directories found matching 'dist' 11:13:58 INFO - no previously-included directories found matching '.git*' 11:13:58 INFO - Successfully installed jsonschema functools32 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:58 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 11:13:58 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 11:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:13:58 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 11:13:58 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 11:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:58 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 11:13:58 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 11:13:58 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 11:13:58 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 11:13:58 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 11:13:58 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 11:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:01 INFO - Downloading docopt-0.6.1.tar.gz 11:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:01 INFO - Running setup.py install for blobuploader 11:14:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:01 INFO - Running setup.py install for requests 11:14:01 INFO - Running setup.py install for docopt 11:14:01 INFO - Successfully installed blobuploader requests docopt 11:14:01 INFO - Cleaning up... 11:14:01 INFO - Return code: 0 11:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:01 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')]} 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 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')]} 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:14:01 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 11:14:01 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 11:14:01 INFO - Using env: {'DISPLAY': ':0', 11:14:01 INFO - 'HOME': '/home/cltbld', 11:14:01 INFO - 'LANG': 'en_US.UTF-8', 11:14:01 INFO - 'LANGUAGE': 'en_US:en', 11:14:01 INFO - 'LOGNAME': 'cltbld', 11:14:01 INFO - 'MAIL': '/var/mail/cltbld', 11:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:01 INFO - 'MOZ_NO_REMOTE': '1', 11:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:01 INFO - 'NO_EM_RESTART': '1', 11:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:01 INFO - 'PWD': '/builds/slave/test', 11:14:01 INFO - 'SHELL': '/bin/bash', 11:14:01 INFO - 'SHLVL': '1', 11:14:01 INFO - 'TERM': 'linux', 11:14:01 INFO - 'TMOUT': '86400', 11:14:01 INFO - 'USER': 'cltbld', 11:14:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:01 INFO - '_': '/tools/buildbot/bin/python'} 11:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:02 INFO - Running setup.py (path:/tmp/pip-ym0d8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:02 INFO - Running setup.py (path:/tmp/pip-DzC1zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:02 INFO - Running setup.py (path:/tmp/pip-3t98kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:02 INFO - Running setup.py (path:/tmp/pip-un8F8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:02 INFO - Running setup.py (path:/tmp/pip-W0_4Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:02 INFO - Running setup.py (path:/tmp/pip-f_Nljj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:02 INFO - Running setup.py (path:/tmp/pip-bt0SQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:02 INFO - Running setup.py (path:/tmp/pip-xyYfu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:02 INFO - Running setup.py (path:/tmp/pip-hoitWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:02 INFO - Running setup.py (path:/tmp/pip-CJtjWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:02 INFO - Running setup.py (path:/tmp/pip-VXCw53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:02 INFO - Running setup.py (path:/tmp/pip-IGPyvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:02 INFO - Running setup.py (path:/tmp/pip-S122Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:02 INFO - Running setup.py (path:/tmp/pip-jp2kqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:03 INFO - Running setup.py (path:/tmp/pip-y9gGJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:03 INFO - Running setup.py (path:/tmp/pip-CzWYiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:03 INFO - Running setup.py (path:/tmp/pip-VCSTaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:03 INFO - Running setup.py install for manifestparser 11:14:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:03 INFO - Running setup.py install for mozcrash 11:14:03 INFO - Running setup.py install for mozdebug 11:14:03 INFO - Running setup.py install for mozdevice 11:14:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:03 INFO - Running setup.py install for mozfile 11:14:03 INFO - Running setup.py install for mozhttpd 11:14:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:03 INFO - Running setup.py install for mozinfo 11:14:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:03 INFO - Running setup.py install for mozInstall 11:14:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Running setup.py install for mozleak 11:14:04 INFO - Running setup.py install for mozlog 11:14:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Running setup.py install for moznetwork 11:14:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Running setup.py install for mozprocess 11:14:04 INFO - Running setup.py install for mozprofile 11:14:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Running setup.py install for mozrunner 11:14:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:04 INFO - Running setup.py install for mozscreenshot 11:14:04 INFO - Running setup.py install for moztest 11:14:04 INFO - Running setup.py install for mozversion 11:14:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:05 INFO - Cleaning up... 11:14:05 INFO - Return code: 0 11:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:05 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:14:05 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 11:14:05 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 11:14:05 INFO - Using env: {'DISPLAY': ':0', 11:14:05 INFO - 'HOME': '/home/cltbld', 11:14:05 INFO - 'LANG': 'en_US.UTF-8', 11:14:05 INFO - 'LANGUAGE': 'en_US:en', 11:14:05 INFO - 'LOGNAME': 'cltbld', 11:14:05 INFO - 'MAIL': '/var/mail/cltbld', 11:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:05 INFO - 'MOZ_NO_REMOTE': '1', 11:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:05 INFO - 'NO_EM_RESTART': '1', 11:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:05 INFO - 'PWD': '/builds/slave/test', 11:14:05 INFO - 'SHELL': '/bin/bash', 11:14:05 INFO - 'SHLVL': '1', 11:14:05 INFO - 'TERM': 'linux', 11:14:05 INFO - 'TMOUT': '86400', 11:14:05 INFO - 'USER': 'cltbld', 11:14:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:05 INFO - '_': '/tools/buildbot/bin/python'} 11:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:05 INFO - Running setup.py (path:/tmp/pip-qFTsgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:05 INFO - Running setup.py (path:/tmp/pip-pNzs9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:05 INFO - Running setup.py (path:/tmp/pip-IehzDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:05 INFO - Running setup.py (path:/tmp/pip-xCvTev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:05 INFO - Running setup.py (path:/tmp/pip-T4WXeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:05 INFO - Running setup.py (path:/tmp/pip-mrAORj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:05 INFO - Running setup.py (path:/tmp/pip-Pb0ri9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:05 INFO - Running setup.py (path:/tmp/pip-ZyrQeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:05 INFO - Running setup.py (path:/tmp/pip-QnUyXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:05 INFO - Running setup.py (path:/tmp/pip-K9mZxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:06 INFO - Running setup.py (path:/tmp/pip-ybYpQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:06 INFO - Running setup.py (path:/tmp/pip-XQjReG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:06 INFO - Running setup.py (path:/tmp/pip-odxABO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:06 INFO - Running setup.py (path:/tmp/pip-Yc527U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:06 INFO - Running setup.py (path:/tmp/pip-w66RD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:06 INFO - Running setup.py (path:/tmp/pip-LTfhBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:06 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)) 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:06 INFO - Running setup.py (path:/tmp/pip-NiWmE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:08 INFO - Downloading blessings-1.6.tar.gz 11:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:08 INFO - Installing collected packages: blessings 11:14:08 INFO - Running setup.py install for blessings 11:14:08 INFO - Successfully installed blessings 11:14:08 INFO - Cleaning up... 11:14:08 INFO - Return code: 0 11:14:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:08 INFO - Reading from file tmpfile_stdout 11:14:08 INFO - Current package versions: 11:14:08 INFO - argparse == 1.2.1 11:14:08 INFO - blessings == 1.6 11:14:08 INFO - blobuploader == 1.2.4 11:14:08 INFO - docopt == 0.6.1 11:14:08 INFO - functools32 == 3.2.3-2 11:14:08 INFO - jsonschema == 2.5.1 11:14:08 INFO - manifestparser == 1.1 11:14:08 INFO - mozInstall == 1.12 11:14:08 INFO - mozcrash == 0.17 11:14:08 INFO - mozdebug == 0.1 11:14:08 INFO - mozdevice == 0.48 11:14:08 INFO - mozfile == 1.2 11:14:08 INFO - mozhttpd == 0.7 11:14:08 INFO - mozinfo == 0.9 11:14:08 INFO - mozleak == 0.1 11:14:08 INFO - mozlog == 3.3 11:14:08 INFO - moznetwork == 0.27 11:14:08 INFO - mozprocess == 0.23 11:14:08 INFO - mozprofile == 0.28 11:14:08 INFO - mozrunner == 6.12 11:14:08 INFO - mozscreenshot == 0.1 11:14:08 INFO - mozsystemmonitor == 0.3 11:14:08 INFO - moztest == 0.7 11:14:08 INFO - mozversion == 1.4 11:14:08 INFO - psutil == 3.1.1 11:14:08 INFO - requests == 1.2.3 11:14:08 INFO - wsgiref == 0.1.2 11:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 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 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:14:08 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 11:14:08 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 11:14:08 INFO - Using env: {'DISPLAY': ':0', 11:14:08 INFO - 'HOME': '/home/cltbld', 11:14:08 INFO - 'LANG': 'en_US.UTF-8', 11:14:08 INFO - 'LANGUAGE': 'en_US:en', 11:14:08 INFO - 'LOGNAME': 'cltbld', 11:14:08 INFO - 'MAIL': '/var/mail/cltbld', 11:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:08 INFO - 'MOZ_NO_REMOTE': '1', 11:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:08 INFO - 'NO_EM_RESTART': '1', 11:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:08 INFO - 'PWD': '/builds/slave/test', 11:14:08 INFO - 'SHELL': '/bin/bash', 11:14:08 INFO - 'SHLVL': '1', 11:14:08 INFO - 'TERM': 'linux', 11:14:08 INFO - 'TMOUT': '86400', 11:14:08 INFO - 'USER': 'cltbld', 11:14:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:08 INFO - '_': '/tools/buildbot/bin/python'} 11:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 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)) 11:14:09 INFO - Cleaning up... 11:14:09 INFO - Return code: 0 11:14:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb36afb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29dd850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', '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 11:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:09 INFO - Using env: {'DISPLAY': ':0', 11:14:09 INFO - 'HOME': '/home/cltbld', 11:14:09 INFO - 'LANG': 'en_US.UTF-8', 11:14:09 INFO - 'LANGUAGE': 'en_US:en', 11:14:09 INFO - 'LOGNAME': 'cltbld', 11:14:09 INFO - 'MAIL': '/var/mail/cltbld', 11:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:09 INFO - 'MOZ_NO_REMOTE': '1', 11:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:09 INFO - 'NO_EM_RESTART': '1', 11:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:09 INFO - 'PWD': '/builds/slave/test', 11:14:09 INFO - 'SHELL': '/bin/bash', 11:14:09 INFO - 'SHLVL': '1', 11:14:09 INFO - 'TERM': 'linux', 11:14:09 INFO - 'TMOUT': '86400', 11:14:09 INFO - 'USER': 'cltbld', 11:14:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:09 INFO - '_': '/tools/buildbot/bin/python'} 11:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:09 INFO - Cleaning up... 11:14:09 INFO - Return code: 0 11:14:09 INFO - Running post-action listener: _resource_record_post_action 11:14:09 INFO - Running post-action listener: _start_resource_monitoring 11:14:09 INFO - Starting resource monitoring. 11:14:09 INFO - [mozharness: 2016-08-31 18:14:09.460241Z] Finished create-virtualenv step (success) 11:14:09 INFO - [mozharness: 2016-08-31 18:14:09.460692Z] Running install step. 11:14:09 INFO - Running pre-action listener: _resource_record_pre_action 11:14:09 INFO - Running main action method: install 11:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:09 INFO - Reading from file tmpfile_stdout 11:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:09 INFO - Reading from file tmpfile_stdout 11:14:09 INFO - Output received: 11:14:09 INFO - Usage: mozinstall [options] installer 11:14:09 INFO - Options: 11:14:09 INFO - -h, --help show this help message and exit 11:14:09 INFO - -d DEST, --destination=DEST 11:14:09 INFO - Directory to install application into. [default: 11:14:09 INFO - "/builds/slave/test"] 11:14:09 INFO - --app=APP Application being installed. [default: firefox] 11:14:09 INFO - mkdir: /builds/slave/test/build/application 11:14:09 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'] 11:14:09 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 11:14:27 INFO - Reading from file tmpfile_stdout 11:14:27 INFO - Output received: 11:14:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:14:27 INFO - Running post-action listener: _resource_record_post_action 11:14:27 INFO - [mozharness: 2016-08-31 18:14:27.613146Z] Finished install step (success) 11:14:27 INFO - [mozharness: 2016-08-31 18:14:27.613427Z] Running run-tests step. 11:14:27 INFO - Running pre-action listener: _resource_record_pre_action 11:14:27 INFO - Running main action method: run_tests 11:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:27 INFO - Python 2.7.3 11:14:27 INFO - Return code: 0 11:14:27 INFO - grabbing minidump binary from tooltool 11:14:27 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')]} 11:14:27 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 0x29d8370>, '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 0x29db8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dbd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:27 INFO - Return code: 0 11:14:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:14:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:14:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 11:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 11:14:27 INFO - Using env: {'DISPLAY': ':0', 11:14:27 INFO - 'HOME': '/home/cltbld', 11:14:27 INFO - 'LANG': 'en_US.UTF-8', 11:14:27 INFO - 'LANGUAGE': 'en_US:en', 11:14:27 INFO - 'LOGNAME': 'cltbld', 11:14:27 INFO - 'MAIL': '/var/mail/cltbld', 11:14:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:27 INFO - 'MOZ_NO_REMOTE': '1', 11:14:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:27 INFO - 'NO_EM_RESTART': '1', 11:14:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:27 INFO - 'PWD': '/builds/slave/test', 11:14:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:27 INFO - 'SHELL': '/bin/bash', 11:14:27 INFO - 'SHLVL': '1', 11:14:27 INFO - 'TERM': 'linux', 11:14:27 INFO - 'TMOUT': '86400', 11:14:27 INFO - 'USER': 'cltbld', 11:14:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051', 11:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:27 INFO - '_': '/tools/buildbot/bin/python'} 11:14:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 11:14:27 INFO - mozversion application_buildid: 20160831083037 11:14:27 INFO - mozversion application_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 11:14:27 INFO - mozversion application_display_name: Nightly 11:14:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:27 INFO - mozversion application_name: Firefox 11:14:27 INFO - mozversion application_remotingname: firefox 11:14:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:14:27 INFO - mozversion application_vendor: Mozilla 11:14:27 INFO - mozversion application_version: 51.0a1 11:14:27 INFO - mozversion platform_buildid: 20160831083037 11:14:27 INFO - mozversion platform_changeset: 51afefd5f63d13b28b304c52301818cfad7d229b 11:14:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:14:27 INFO - mozversion platform_version: 51.0a1 11:14:27 INFO - using testdate: 1472667267 11:14:27 INFO - actual date: 1472667267 11:14:27 INFO - starting webserver on 'localhost:51692' 11:14:27 INFO - SUITE-START | Running 2 tests 11:14:27 INFO - TEST-START | dromaeo_css 11:14:27 INFO - operating with platform_type : linux_ 11:14:27 INFO - Initialising browser for dromaeo_css test... 11:14:27 INFO - TEST-INFO | started process 13631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpug7VQR/profile http://localhost:51692/getInfo.html) 11:14:32 INFO - PROCESS | 13631 | __metrics Screen width/height:1600/1200 11:14:32 INFO - PROCESS | 13631 | colorDepth:24 11:14:32 INFO - PROCESS | 13631 | Browser inner width/height: 1024/697 11:14:32 INFO - PROCESS | 13631 | __metrics 11:14:33 INFO - PROCESS | 13631 | 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" 11:14:33 INFO - PROCESS | 13631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:33 INFO - PROCESS | 13631 | console.error: PushService: 11:14:33 INFO - PROCESS | 13631 | stateChangeProcessEnqueue: Error transitioning state 11:14:33 INFO - PROCESS | 13631 | UnknownError 11:14:34 INFO - TEST-INFO | 13631: exit 0 11:14:34 INFO - Browser initialized. 11:14:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:34 INFO - TEST-INFO | started process 13713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpug7VQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:46 INFO - PROCESS | 13713 | RSS: Main: 180142080 11:14:46 INFO - PROCESS | 13713 | 11:15:38 INFO - PROCESS | 13713 | 1472667338263 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] 11:17:47 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51692/tests/dromaeo/cssquery-ext.html) 11:17:48 INFO - PROCESS | 13713 | RSS: Main: 307400704 11:17:48 INFO - PROCESS | 13713 | 11:20:51 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-ext.html (next: http://localhost:51692/tests/dromaeo/cssquery-jquery.html) 11:20:52 INFO - PROCESS | 13713 | RSS: Main: 273264640 11:20:52 INFO - PROCESS | 13713 | 11:23:54 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51692/tests/dromaeo/cssquery-mootools.html) 11:23:54 INFO - PROCESS | 13713 | RSS: Main: 215109632 11:23:54 INFO - PROCESS | 13713 | 11:26:56 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51692/tests/dromaeo/cssquery-prototype.html) 11:26:57 INFO - PROCESS | 13713 | RSS: Main: 213037056 11:26:57 INFO - PROCESS | 13713 | 11:30:00 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51692/tests/dromaeo/cssquery-yui.html) 11:30:00 INFO - PROCESS | 13713 | RSS: Main: 213925888 11:30:00 INFO - PROCESS | 13713 | 11:33:03 INFO - PROCESS | 13713 | Cycle 1(1): loaded http://localhost:51692/tests/dromaeo/cssquery-yui.html (next: http://localhost:51692/tests/dromaeo/cssquery-dojo.html) 11:33:04 INFO - PROCESS | 13713 | RSS: Main: 285294592 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | __start_tp_report 11:33:04 INFO - PROCESS | 13713 | _x_x_mozilla_page_load 11:33:04 INFO - PROCESS | 13713 | _x_x_mozilla_page_load_details 11:33:04 INFO - PROCESS | 13713 | |i|pagename|runs| 11:33:04 INFO - PROCESS | 13713 | |0;dojo.html;3064.2645765016387;3074.6156730408698;3076.4001019801135;3118.73490753286;3135.858886350114;5246.029484545362;5301.946980530193;5314.627976041669;5389.757460914258;5418.24144619753;5413.756380962856;5454.127339625661;5465.07093794055;5497.900419916023;5504;4765.8570242892765;4856.3201151838775;4868.391451068616;4871.634627402959;5057.342545469084;4959.925601115968;4992.950070499285;5013.573846223076;5018.34761481007;5023.7236951967625;4845.370101886768;4849.539293767087;4880.8047678092835;4927.605791536668;4986.426560945483;4832.44426890905;4866.878328041792;4867.7079375237245;4926.975365123188;4982.352294201731;4886.584640305578;4902.950970490285;4910.288008238786;4922.33548470959;4925.236588328815;5303.628745987782;5419.430959749248;5468.425815289377;5475.425080366544;5504.146857237135;5840.503557197643;5851;5868.295804503487;5869.677167755772;5878.853028674274;5888.116782482662;5895.64626122434;5898.734556944905;5907.527397808165;5909.9704501477645;5275.622541296322;5393.19102134679;5436.864078398072;5443.918341224885;5520.199571062173;5959.970200148971;5966.970165149233;5968.7015649217365;5969.671668058299;5976.671283079472;5715.599908006483;5723.685197314105;5725.198472213893;5725.914111288334;5729.88540229193;5551.72241387929;5678.886422271531;5722.170285308607;5730.054541000772;5793.8841223175305;5638.830835074954;5693.914591281134;5696.231008813757;5704.828855134353;5719.170720245541;5676.801311954062;5709.229254050733;5729.570282228766;5729.8567535811935;5730.426957304237;4437.267850804581;4472.485664148599;4516.774161291923;4516.954830451654;4557.475890272594;3997.8200980955926;4000.5199376075057;4000.879973600797;4001.8599349022643;4043.433919251307;5551.944480555224;5553.361363443175;5556.527695145958;5560.193771903051;5606.6916319602;5642.266505354278;5785.0454674979;5812.79655212074;5849.034909240013;5911.527077833763;5532.5020748132865;5540.972295138498;5547.140193270049;5547.750351234205;5551.444855514416;5001.4998500149695;5029.119904016856;5042.621803364689;5043.924341134886;5097.082525145435;5942.078977758454;5988.431099045583;6024.608400453956;6032.366601506778;6139.938600614116;5894.38108998549;5895.734691938787;5897.911531326948;5902;5905.911411328748;6014.0678194879865;6051.697415129138;6058.5153187745755;6063.060225665029;6063.939360606338;5609.691466969356;5612.130119831432;5624.072028115479;5646.322441307069;5736.053551164011;5734.426557344399;5760.0783874579865;5773.422657734193;5773.4803867650435;5773.711314434177;5643.830685079454;5653.943460565341;5654.717264136859;5658.122990936411;5660.207570940154;5610.214569960127;5653.2085508028085;5702.51528620072;5713.8285851424525;5814.04068328721;5652.717364131695;5655.745491452977;5660.462256085665;5665;5676.2337084493065;5736.4550367715;5765.077587586134;5769.798057067983;5775.9133612996675;5776.306843178677;5438.619296649196;5554.861128471821;5564.443555644403;5609.046462101371;5643.097104463266 11:33:04 INFO - PROCESS | 13713 | |1;ext.html;558.8580958836637;591.0720169334146;602.9698515074246;620.4230066038585;629.0312918106117;42223.155536889244;43979.56020439799;44070.559294407045;44685.55314446855;44832;42312.788436057774;45854.77072614641;45970.31044534335;45979.31031034537;46006;8105.837883242331;9033.728988130366;9181.816363672722;9187.999999999967;10721.83917241242;10511.63209287675;10926.235163538555;10929.234953553254;10934.781304373908;10940.4529773511;10923.071538919201;10978.505967231455;11005.284656497342;11011.174161937846;11012.39431831249;10886.782264354708;10959.616413425572;10966.835497467544;10984.06635435989;10984.945075274652;10798.51406686701;10883.78232435347;10886.945565272123;10888.67333979974;10891.891081089247;42845.35731964023;43225.13549729019;43306;43307.35038974418;43366;3494.5806503219524;3495.9300813983577;3530.5410296661526;3572.6427357264324;3642.927141457156;32428.189295267806;32597.511037334458;33366.3326733464;33710.49434258488;34732;4299.957000429987;4345.782710864444;4366.170427618742;4371.30059190528;4443.289073748185;345014;345140;346930;347023.2648836765;347043;58380;58697.413025870046;58797.70601146967;58837.70581147067;58888;61080.38919610836;61334.693326533976;61436;61494;61506.384936150964;14506;14613.123212607064;14642.853571464362;14687.632809179857;14725.19011454359;11455.713607159887;11617.244879082833;11639.359835208976;11656.766864662659;11664.475098620582;15682;16628.750568741478;16835;16940.91529542369;16987.320507179822;6049.243844519435;6092.116643086728;6117.204763380821;6223.782167624111;6251.718672659741;962.8459446488669;1006.7885743993843;1022.4734261855151;1077.342820879263;1093.6117678224116;32467;32491.18772030718;32627.347453050807;33075.50386744153;33618;1091.82530795074;1101.2236373356764;1101.7741363020561;1114.7436089699415;1120.6638008597552;16311.918440407722;17097.58423236103;17100.144992750313;17210;17449.38927137544;497363;499418;501569;507188;510875;59618.9514415557;59825;60021;60064.69967650134;60129.69935150296;1262.873712628748;1289.4390939940968;1323.1399590266403;1333.379978310071;1349.9460021599223;30390.848045760515;31438;32362.821948489072;32602.83698581492;33045.17387065342;51670.74164629153;51889.48110518847;51911.48088519218;52096.47903521068;52142.47857521528;430335;431126;431763;432090;432589;33758.662413375554;34423.31153376969;41454.585454145075;41895.371569427094;42463.787681061396;46925.76537117293;47529.28706069342;47708.284375735086;47950;48144.27783583179;40020.399694005195;40305.74086816056;40364.3945340826;41438.79280603577;42844;39541.40687889626;39809;40288.79855600703;41501.792491037355;41758;39776.63658573043;41123;41379;41519.792401037805;41529.58470415257;32412.675873241908;35561.64438355583;35933.460998085575;36360.27279454449;37690.24619507649;28049.57925631158;28327.43345133127;28369.574456383583;28403;28453 11:33:04 INFO - PROCESS | 13713 | |2;jquery.html;375.4780854612088;377.4074702716734;410.37417937645085;412.13657387772616;418.493622716513;14235.288235588205;17311.740323895152;18068.457946261617;19573.119209635566;19617.901910490444;17922.462326130204;17945.551361215978;18545.44363669092;19408.708869366936;19520.121594528246;5555.833325000256;5746.0806270996645;5747.568932330071;5765.1352297155345;5774.769009239625;4120.649744771698;5644.096944488882;5708.942910570903;6139.938600613981;6441.162648855642;6328.588641738295;6423.550351475398;6435.967820160892;6440.033994900756;6440.13058237139;6132.386761323876;6273.184486016811;6296.024116261987;6309.3690630937;6313.337099604544;5520.420355862617;5598.44015598441;5599.832005039855;5607.158926161068;5608.579356548275;23101.884490577606;23354.416139596648;23467.765322346728;23488.412789680224;23667;2345.6950596422357;2352.6472278439965;2443.6823212982376;2600.375909781658;2897.898573549937;13955.511557095453;14670.19313937733;14805.481808136663;14819.77770333446;15381.230938453144;1856.2574970011967;1904.4001139640968;1911.3788018893777;1960.2257108442086;1991.08306331224;80150;81045.59477202635;81470.59264703697;83306;83345.58327208385;10590.922494839388;10790.838137427945;10876.673699789018;11111.49991251978;11143.567892416508;15496;15510.922445387701;15514.301856416489;15533.378664853279;15578.143202123993;7726.497777644435;7812.804679882935;8017.358611311081;8098.31164351025;8121.715739949192;7195.820104497429;7225.819354516179;7234.348908598251;7432.368248698921;7439.628018599048;6413.422791948747;6523.902141467882;6645.435138013323;6695.765648202387;6800.693968771318;1887.584731359099;1909.76127984002;1947.931822386238;1958.735570697966;1985.4936991067475;847.2132451648237;940.167951363035;950.6957773512548;969.2391472693902;995.3082607587658;20046.89976550108;20125.39623811288;20241.797582024286;20325.390238292875;20396.796032039787;964.8070385922844;968.6270785747538;991.9454430006275;1010.1767059846349;1030.253066526777;11087.05760010408;11298.943505282585;11353.716157095974;11380.146489013357;11388;483018;494336;496632;498512;504556;97100.51449742707;100495.49752251191;104065;104971.0277523634;106153.46923265334;1038.5430410619304;1048.1719441641171;1052.6157952347492;1058.5448257249457;1083.9945800270948;17217.225224864662;17387.739183912505;17900.641987159925;18099.54751131232;18373.63252734911;28382.43235135327;33481.16297092592;41928;42530;42846.57153428426;55620.443795563144;56173.43826561682;57576.71211643915;62636;63386;7528.4353673473615;7647.694092236248;7839.33365663925;7948.244916733132;7985.480943738638;11414.657560273205;12543.623691289276;13158.934205329295;13358.131721438076;13597.252151131783;11381.203315767816;11484.310941343547;11675.76648467009;11792.23350482216;12306.200096993667;11197.776044479227;11569.710757231136;11580.42097895085;11663.76672466563;12235.143539952118;10922.726931826768;11194.776104477702;11495.367754773568;11628.709282268012;12352.197107188003;7711.922880771121;7841.490303130278;7877.133515313426;7928.524288542706;8197.947788000862;11294.60468883585;11561.265810128549;11632.76734465289;11710.88289117132;11756.82364764512 11:33:04 INFO - PROCESS | 13713 | |3;mootools.html;1313.3105119812103;1472.5435115114315;1503.2033022498076;1632.738761798112;1812.8912265264078;8721.127887211283;8887.155720206578;8914.375993680445;9179.036201198878;9184.12750788674;8799;8965.775855603613;8967.551622418885;8979.057198994109;8993.055729148444;2090.6341390256644;2296.1389478945393;2383.1301574925155;2425.5391475619663;2430.9756902431013;2375.2874137758604;2401.7478164792706;2407.9398015049587;2409.8915548800346;2411.6744239527616;2293.6444851048113;2299.4941112955207;2345.108858633717;2390.40239940015;2394.389430695179;2299.4366380236947;2346.073301046086;2357.24568138195;2370.4903445759246;2378.988105059481;2329.5690297294886;2362.11420717231;2372.79831214347;2374.204641445118;2375.869327187004;9057.320700947455;9129.634814607407;9139.954300228523;9144.40561363516;9145.634174633007;5237.319148510669;5354.919676204821;5380.085385484438;5426.023315803154;5434.619576629638;3312.635610082889;3492.3539145257955;3534.2754735279204;3534.787912725219;3539.43369060949;1142.7200335917753;1194.796884529632;1201.447334226257;1221.6579357779835;1241.3172754984723;12499.375031248492;12746.362681865963;12747.61757147287;12778.744425111445;12818.935905320506;4375.146846364928;4592.931106033412;4661.463931647904;4697.8355757548325;4784.665073444895;10685.786284274427;10702.571897124184;10704.94647526773;10717.035466808025;10719.249652524248;5308.097623403954;5327.38735045467;5335.093034184198;5335.759890804923;5339.652922560022;4364.54172311909;4767.856964291077;4852.272159176152;4892.535209155125;4897.755112244374;3990.521137463523;4040.41413994975;4143.647789937889;4188.267053265667;4196.139791342767;1276.6553030681664;1279.1730276089945;1299.7270573179549;1312.8424589049375;1320.7556602028656;904.1771987491351;906.5875026862761;937.6765016069445;938.5166639180827;968.4963818814177;5698.971505142447;5822.097574875901;5902.585376324755;5911;5941.643501389931;448.30960321105135;451.51687694166924;453.38339857793375;455.28065656263027;457.78941686823765;3928.5482169550296;3971.960280397159;3988.3219852625125;4034.23349563582;4072.75563466193;11142.331460112418;11426.2001659883;11514.76970460603;11522.884771152181;11532.596359127558;11425;11425.08599312053;11444.885551144549;11446.313221206754;11467.31196128235;8342.207490288412;8399.496030238206;8418.494890306602;8500.872486912702;8513.489190648457;5709.314882214161;5716.714164291852;5738.598298119258;5776.480116789509;5804.941950580609;10270.537825798006;10353.4305613192;10416.583336666448;10445.9477702611;10521.526531305957;9984.101430871257;10369.377837329785;10372.740681483023;10553.472326383804;10675.89324106749;7461.850762984602;7925;7938.841223175619;8116.472429292077;8137.389695772722;8807.735767926972;8995.23540499065;8995.91004089977;9002;9002;7938.960305198668;8123.837523249384;8138.633761480866;8277.255047045795;8382.706605268786;7896.7236146734585;8009.8398032040195;8013.038435387791;8141.307988821017;8253.33973282148;7035.542689725152;7342.816429589303;7402.259774022555;7461.664225109775;7471.738489152854;5299.735013249399;5311.203319502106;5370.597205209547;5401.2168235606405;5519.917201242065;5355.651882627617;5361.812336568201;5370.301860758076;5370.731463426735;5405.918911216414 11:33:04 INFO - PROCESS | 13713 | |4;prototype.html;336.8248510774397;341.0631114615934;341.62933217459056;347.9930401391971;350.3448551209239;5372.4090350061515;5384.903680383775;5399.865003374913;5401.108817045193;5409.404965453802;5273.973630131844;5310.6017048721405;5335.186036747505;5350.117230656937;5362.82017956049;3922.529296484419;4002.459667944819;4129.772862492577;4150.3359462486005;4153.460050193471;4123.938030984507;4137.937930931039;4139.8965025874295;4159.896002599929;4179.540250572434;4100.261952848486;4121.278776214151;4127;4127.380892866064;4142.71001029928;3890.1636148228126;3930.5872883347265;4131.669466442708;4164.8542301019315;4169.124483858393;3667.0832291927018;3689.3912504436735;3696.316181506403;3701.2782507411066;3706.5737440194453;5151.871203219912;5159.948400515985;5161.870953226162;5186.7147306898105;5186.818461353834;4462.843800466968;4651.348811166439;4678.3216433616935;4684.344191813149;4743.430788305391;5448.575383954142;5450.4549545045575;5462.562994960434;5464.754086066137;5466.617336786427;3963.5243770747693;4000.9399859002137;4001.7198796084285;4001.8599349022643;4013.57857424972;5502.80740174092;5640;5659.009673307196;5691.345495268014;5697;4057.5333836609166;4062.289099407592;4064.8170832312617;4069.715119941635;4083.6528895044253;4150.792460376969;4169.395437661522;4173.8956526087095;4195.286801243796;4195.496540415109;4651.651126165551;4713.976430117896;4754.809807607726;4758.476567577563;4775.21209000511;5510.614257002052;5516.779328826882;5529.806456774074;5543.616245014602;5590.440955904377;1358.7758019926798;1361.8229630148016;1370.7943808428815;1371.430856194688;1374.3677908162158;878.5563290538365;899;912.5118061836886;931.8136372725346;945.933784635069;5201.583873290203;5306.612024588951;5376.973115134399;5390.652336915771;5418.783248670009;5628.97185514078;5638.605297629127;5670;5683.067756962652;5690.800821971211;5193.7403129844115;5327.520523152934;5353.625246232804;5359.998400895511;5361.08861493547;2948.758943203181;2958.7189217024347;2968.7773416993814;2972.0043785331723;2983.34366439383;5769.278840144982;5801.506871915934;5815.563832712479;5818.5345172386105;5823.660558071582;5395.433479484597;5607.186957891165;5638.2670252866865;5660.349059858087;5674.432556744375;5739.454751798572;5754.280714910637;5811.564132690065;5817.004242814954;5863.17915491823;5382.3541175059245;5561.694106824163;5646;5651.6043876928225;5672.574556908331;5587.357453892854;5597.3412629000895;5614.294565586693;5624.437556244507;5635.182898479779;5774.624649397776;5790.189373487631;5814.680192589448;5824.883502330014;5842.38654941242;3925.7644541327613;4004.9574716894012;4066.512018557674;4086.9795651021554;4088.570700076449;5645.294338207724;5646.35066967304;5652.152177173457;5661.405552416937;5682.602217844877;5529.364123125731;5557.249771280825;5562.969516126665;5580.330360356783;5584.413636568264;5223.373195216598;5417.864553386197;5500.70733377648;5503.972480137734;5509.3664228612615;5440.53755430777;5448.291722076105;5453.182022696627;5461.617686761889;5468.972655136698;5269.262303277467;5334.653247538898;5533.142362933751;5540.196671482693;5558.776489404109;5441.428649991693;5445.292112025411;5457.399686034453;5458.536024437967;5460.672359658433 11:33:04 INFO - PROCESS | 13713 | |5;yui.html;782.636074225485;785.3952456608412;803.5178892664399;809.7768647940574;819.7212947597816;15540.689186216268;16339.18304084797;16724.498265052036;16808;16896.32414703412;14670.559883203494;14927.32827022784;15028.774568381456;15060.924695376536;15061.246937653128;783.8824176373547;787.1970589998199;794.146292735309;794.4041968523608;796.1958421993799;650.8015055408099;774.5004472115482;796.7131832540281;806.4717609965483;808.4219782855257;859.1151114352227;860.101194252005;861.6294993152973;862.0861886400404;862.1464749897619;848.6562942008496;848.898132224134;848.9787755306105;849.3375167369462;849.5794581682076;500.8622628777079;594.2245369792419;605.449041372349;609.3784339973247;624.307019208678;13073.215607063607;13109.344532773322;13111;13116.081874268804;13119.934400328033;13579.253141077237;14184.716305673828;14221;14253.358598863077;14440.638984025378;12883.871161288454;13094.148880322844;13156.802647960192;13166.670833229151;13313.26777027263;4331.393604895317;4348.21732088224;4404.361367601679;4409.294512877924;4588.49526552079;79957.60021199915;80687;80899.19100808975;82238.58880705618;83558.58220708919;10964.451777411097;11028.889711102947;11082.90440257855;11130.554777808797;11226;19344.226230950604;19421.805781942283;19545.120469578902;19559.0220488975;19590.412287631392;7265.818354541178;7321.74373896911;7350.889736653954;7370.373518251009;7491.363234125051;4358.193734159191;4385.429894113745;4623.12160689468;4660.997885454643;4686.203345431285;3330.400527905;3434.055634700477;3464.72282217422;3471.7743346682387;3472.444408894615;622.1255130804591;631.311870061635;632.8357018995048;637.1462240597622;653.9607623542603;664.3489380407228;669.6517810738388;675.9391654751096;679.8164495586165;696.5263620737845;8495.787605309793;8796.648134074694;8816.515091669891;8876.334274929406;8909.43160524672;635.6980434293766;655.3053763011224;671.8857794175002;675.1965161457849;703.7818276334352;4248.596383343577;4416.381706561084;4453.332000199931;4471.306947423154;4473.932891006638;91072;116781.96487991743;118661.40669296599;123003;126644.36677816552;59264;60003;61049.69475152596;84339.57830210932;100293;87114;88067;88759.55620221858;88835;89255;8488.74533763988;8780.146452403122;8859.468431894107;8906.643734250816;8913.777155570902;37515.81242093772;37743;49198.50801491939;49500.50499494959;50443.49556504535;63284.36715632785;64378.678106609164;75465;76001.61999189969;77110;12059.51761929513;12064.75870482568;12125.090618203494;12166.39168041612;12433.751324973631;14653.194074326015;14868.40526378976;15117.54647360581;15346.23268836576;15661.530154095395;11528.481218345027;14252.501162459264;14514.782278266046;15302.846971530587;15306.387744490095;14392.82453943628;14702.411903524167;14815.333310001291;14949.83227432038;15390.307436165176;14275.14349139055;14289.472247452431;14594.708105838035;14888.106713596786;14920;9886.060824221688;9988.200943924323;10572.788544229226;10583.417912014605;10595.894041059491;9829.803403932025;9832.459214743258;10457.215708821717;10764.138868890626;10795.32783919979 11:33:04 INFO - PROCESS | 13713 | __end_tp_report 11:33:04 INFO - PROCESS | 13713 | __start_cc_report 11:33:04 INFO - PROCESS | 13713 | _x_x_mozilla_cycle_collect,1119 11:33:04 INFO - PROCESS | 13713 | __end_cc_report 11:33:04 INFO - PROCESS | 13713 | __startTimestamp1472668384004__endTimestamp 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | ------- Summary: start ------- 11:33:04 INFO - PROCESS | 13713 | Number of tests: 6 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#0] dojo.html Cycles:165 Average:5396.18 Median:5612.13 stddev:616.07 (11.0%) stddev-sans-first:590.17 11:33:04 INFO - PROCESS | 13713 | Values: 3064.3 3074.6 3076.4 3118.7 3135.9 5246.0 5301.9 5314.6 5389.8 5418.2 5413.8 5454.1 5465.1 5497.9 5504.0 4765.9 4856.3 4868.4 4871.6 5057.3 4959.9 4993.0 5013.6 5018.3 5023.7 4845.4 4849.5 4880.8 4927.6 4986.4 4832.4 4866.9 4867.7 4927.0 4982.4 4886.6 4903.0 4910.3 4922.3 4925.2 5303.6 5419.4 5468.4 5475.4 5504.1 5840.5 5851.0 5868.3 5869.7 5878.9 5888.1 5895.6 5898.7 5907.5 5910.0 5275.6 5393.2 5436.9 5443.9 5520.2 5960.0 5967.0 5968.7 5969.7 5976.7 5715.6 5723.7 5725.2 5725.9 5729.9 5551.7 5678.9 5722.2 5730.1 5793.9 5638.8 5693.9 5696.2 5704.8 5719.2 5676.8 5709.2 5729.6 5729.9 5730.4 4437.3 4472.5 4516.8 4517.0 4557.5 3997.8 4000.5 4000.9 4001.9 4043.4 5551.9 5553.4 5556.5 5560.2 5606.7 5642.3 5785.0 5812.8 5849.0 5911.5 5532.5 5541.0 5547.1 5547.8 5551.4 5001.5 5029.1 5042.6 5043.9 5097.1 5942.1 5988.4 6024.6 6032.4 6139.9 5894.4 5895.7 5897.9 5902.0 5905.9 6014.1 6051.7 6058.5 6063.1 6063.9 5609.7 5612.1 5624.1 5646.3 5736.1 5734.4 5760.1 5773.4 5773.5 5773.7 5643.8 5653.9 5654.7 5658.1 5660.2 5610.2 5653.2 5702.5 5713.8 5814.0 5652.7 5655.7 5660.5 5665.0 5676.2 5736.5 5765.1 5769.8 5775.9 5776.3 5438.6 5554.9 5564.4 5609.0 5643.1 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#1] ext.html Cycles:180 Average:59654.22 Median:20666.59 stddev:114133.40 (552.3%) stddev-sans-first:114367.33 11:33:04 INFO - PROCESS | 13713 | Values: 558.9 591.1 603.0 620.4 629.0 42223.2 43979.6 44070.6 44685.6 44832.0 42312.8 45854.8 45970.3 45979.3 46006.0 8105.8 9033.7 9181.8 9188.0 10721.8 10511.6 10926.2 10929.2 10934.8 10940.5 10923.1 10978.5 11005.3 11011.2 11012.4 10886.8 10959.6 10966.8 10984.1 10984.9 10798.5 10883.8 10886.9 10888.7 10891.9 42845.4 43225.1 43306.0 43307.4 43366.0 3494.6 3495.9 3530.5 3572.6 3642.9 32428.2 32597.5 33366.3 33710.5 34732.0 4300.0 4345.8 4366.2 4371.3 4443.3 345014.0 345140.0 346930.0 347023.3 347043.0 58380.0 58697.4 58797.7 58837.7 58888.0 61080.4 61334.7 61436.0 61494.0 61506.4 14506.0 14613.1 14642.9 14687.6 14725.2 11455.7 11617.2 11639.4 11656.8 11664.5 15682.0 16628.8 16835.0 16940.9 16987.3 6049.2 6092.1 6117.2 6223.8 6251.7 962.8 1006.8 1022.5 1077.3 1093.6 32467.0 32491.2 32627.3 33075.5 33618.0 1091.8 1101.2 1101.8 1114.7 1120.7 16311.9 17097.6 17100.1 17210.0 17449.4 497363.0 499418.0 501569.0 507188.0 510875.0 59619.0 59825.0 60021.0 60064.7 60129.7 1262.9 1289.4 1323.1 1333.4 1349.9 30390.8 31438.0 32362.8 32602.8 33045.2 51670.7 51889.5 51911.5 52096.5 52142.5 430335.0 431126.0 431763.0 432090.0 432589.0 33758.7 34423.3 41454.6 41895.4 42463.8 46925.8 47529.3 47708.3 47950.0 48144.3 40020.4 40305.7 40364.4 41438.8 42844.0 39541.4 39809.0 40288.8 41501.8 41758.0 39776.6 41123.0 41379.0 41519.8 41529.6 32412.7 35561.6 35933.5 36360.3 37690.2 28049.6 28327.4 28369.6 28403.0 28453.0 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#2] jquery.html Cycles:180 Average:29536.75 Median:12920.53 stddev:81895.17 (633.8%) stddev-sans-first:82095.64 11:33:04 INFO - PROCESS | 13713 | Values: 375.5 377.4 410.4 412.1 418.5 14235.3 17311.7 18068.5 19573.1 19617.9 17922.5 17945.6 18545.4 19408.7 19520.1 5555.8 5746.1 5747.6 5765.1 5774.8 4120.6 5644.1 5708.9 6139.9 6441.2 6328.6 6423.6 6436.0 6440.0 6440.1 6132.4 6273.2 6296.0 6309.4 6313.3 5520.4 5598.4 5599.8 5607.2 5608.6 23101.9 23354.4 23467.8 23488.4 23667.0 2345.7 2352.6 2443.7 2600.4 2897.9 13955.5 14670.2 14805.5 14819.8 15381.2 1856.3 1904.4 1911.4 1960.2 1991.1 80150.0 81045.6 81470.6 83306.0 83345.6 10590.9 10790.8 10876.7 11111.5 11143.6 15496.0 15510.9 15514.3 15533.4 15578.1 7726.5 7812.8 8017.4 8098.3 8121.7 7195.8 7225.8 7234.3 7432.4 7439.6 6413.4 6523.9 6645.4 6695.8 6800.7 1887.6 1909.8 1947.9 1958.7 1985.5 847.2 940.2 950.7 969.2 995.3 20046.9 20125.4 20241.8 20325.4 20396.8 964.8 968.6 991.9 1010.2 1030.3 11087.1 11298.9 11353.7 11380.1 11388.0 483018.0 494336.0 496632.0 498512.0 504556.0 97100.5 100495.5 104065.0 104971.0 106153.5 1038.5 1048.2 1052.6 1058.5 1084.0 17217.2 17387.7 17900.6 18099.5 18373.6 28382.4 33481.2 41928.0 42530.0 42846.6 55620.4 56173.4 57576.7 62636.0 63386.0 7528.4 7647.7 7839.3 7948.2 7985.5 11414.7 12543.6 13158.9 13358.1 13597.3 11381.2 11484.3 11675.8 11792.2 12306.2 11197.8 11569.7 11580.4 11663.8 12235.1 10922.7 11194.8 11495.4 11628.7 12352.2 7711.9 7841.5 7877.1 7928.5 8197.9 11294.6 11561.3 11632.8 11710.9 11756.8 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#3] mootools.html Cycles:180 Average:5951.55 Median:2525.36 stddev:3460.12 (137.0%) stddev-sans-first:3452.27 11:33:04 INFO - PROCESS | 13713 | Values: 1313.3 1472.5 1503.2 1632.7 1812.9 8721.1 8887.2 8914.4 9179.0 9184.1 8799.0 8965.8 8967.6 8979.1 8993.1 2090.6 2296.1 2383.1 2425.5 2431.0 2375.3 2401.7 2407.9 2409.9 2411.7 2293.6 2299.5 2345.1 2390.4 2394.4 2299.4 2346.1 2357.2 2370.5 2379.0 2329.6 2362.1 2372.8 2374.2 2375.9 9057.3 9129.6 9140.0 9144.4 9145.6 5237.3 5354.9 5380.1 5426.0 5434.6 3312.6 3492.4 3534.3 3534.8 3539.4 1142.7 1194.8 1201.4 1221.7 1241.3 12499.4 12746.4 12747.6 12778.7 12818.9 4375.1 4592.9 4661.5 4697.8 4784.7 10685.8 10702.6 10704.9 10717.0 10719.2 5308.1 5327.4 5335.1 5335.8 5339.7 4364.5 4767.9 4852.3 4892.5 4897.8 3990.5 4040.4 4143.6 4188.3 4196.1 1276.7 1279.2 1299.7 1312.8 1320.8 904.2 906.6 937.7 938.5 968.5 5699.0 5822.1 5902.6 5911.0 5941.6 448.3 451.5 453.4 455.3 457.8 3928.5 3972.0 3988.3 4034.2 4072.8 11142.3 11426.2 11514.8 11522.9 11532.6 11425.0 11425.1 11444.9 11446.3 11467.3 8342.2 8399.5 8418.5 8500.9 8513.5 5709.3 5716.7 5738.6 5776.5 5804.9 10270.5 10353.4 10416.6 10445.9 10521.5 9984.1 10369.4 10372.7 10553.5 10675.9 7461.9 7925.0 7938.8 8116.5 8137.4 8807.7 8995.2 8995.9 9002.0 9002.0 7939.0 8123.8 8138.6 8277.3 8382.7 7896.7 8009.8 8013.0 8141.3 8253.3 7035.5 7342.8 7402.3 7461.7 7471.7 5299.7 5311.2 5370.6 5401.2 5519.9 5355.7 5361.8 5370.3 5370.7 5405.9 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#4] prototype.html Cycles:180 Average:4649.64 Median:5374.69 stddev:1362.41 (25.3%) stddev-sans-first:1327.22 11:33:04 INFO - PROCESS | 13713 | Values: 336.8 341.1 341.6 348.0 350.3 5372.4 5384.9 5399.9 5401.1 5409.4 5274.0 5310.6 5335.2 5350.1 5362.8 3922.5 4002.5 4129.8 4150.3 4153.5 4123.9 4137.9 4139.9 4159.9 4179.5 4100.3 4121.3 4127.0 4127.4 4142.7 3890.2 3930.6 4131.7 4164.9 4169.1 3667.1 3689.4 3696.3 3701.3 3706.6 5151.9 5159.9 5161.9 5186.7 5186.8 4462.8 4651.3 4678.3 4684.3 4743.4 5448.6 5450.5 5462.6 5464.8 5466.6 3963.5 4000.9 4001.7 4001.9 4013.6 5502.8 5640.0 5659.0 5691.3 5697.0 4057.5 4062.3 4064.8 4069.7 4083.7 4150.8 4169.4 4173.9 4195.3 4195.5 4651.7 4714.0 4754.8 4758.5 4775.2 5510.6 5516.8 5529.8 5543.6 5590.4 1358.8 1361.8 1370.8 1371.4 1374.4 878.6 899.0 912.5 931.8 945.9 5201.6 5306.6 5377.0 5390.7 5418.8 5629.0 5638.6 5670.0 5683.1 5690.8 5193.7 5327.5 5353.6 5360.0 5361.1 2948.8 2958.7 2968.8 2972.0 2983.3 5769.3 5801.5 5815.6 5818.5 5823.7 5395.4 5607.2 5638.3 5660.3 5674.4 5739.5 5754.3 5811.6 5817.0 5863.2 5382.4 5561.7 5646.0 5651.6 5672.6 5587.4 5597.3 5614.3 5624.4 5635.2 5774.6 5790.2 5814.7 5824.9 5842.4 3925.8 4005.0 4066.5 4087.0 4088.6 5645.3 5646.4 5652.2 5661.4 5682.6 5529.4 5557.2 5563.0 5580.3 5584.4 5223.4 5417.9 5500.7 5504.0 5509.4 5440.5 5448.3 5453.2 5461.6 5469.0 5269.3 5334.7 5533.1 5540.2 5558.8 5441.4 5445.3 5457.4 5458.5 5460.7 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - PROCESS | 13713 | [#5] yui.html Cycles:180 Average:19903.80 Median:4642.06 stddev:28680.74 (617.8%) stddev-sans-first:28725.26 11:33:04 INFO - PROCESS | 13713 | Values: 782.6 785.4 803.5 809.8 819.7 15540.7 16339.2 16724.5 16808.0 16896.3 14670.6 14927.3 15028.8 15060.9 15061.2 783.9 787.2 794.1 794.4 796.2 650.8 774.5 796.7 806.5 808.4 859.1 860.1 861.6 862.1 862.1 848.7 848.9 849.0 849.3 849.6 500.9 594.2 605.4 609.4 624.3 13073.2 13109.3 13111.0 13116.1 13119.9 13579.3 14184.7 14221.0 14253.4 14440.6 12883.9 13094.1 13156.8 13166.7 13313.3 4331.4 4348.2 4404.4 4409.3 4588.5 79957.6 80687.0 80899.2 82238.6 83558.6 10964.5 11028.9 11082.9 11130.6 11226.0 19344.2 19421.8 19545.1 19559.0 19590.4 7265.8 7321.7 7350.9 7370.4 7491.4 4358.2 4385.4 4623.1 4661.0 4686.2 3330.4 3434.1 3464.7 3471.8 3472.4 622.1 631.3 632.8 637.1 654.0 664.3 669.7 675.9 679.8 696.5 8495.8 8796.6 8816.5 8876.3 8909.4 635.7 655.3 671.9 675.2 703.8 4248.6 4416.4 4453.3 4471.3 4473.9 91072.0 116782.0 118661.4 123003.0 126644.4 59264.0 60003.0 61049.7 84339.6 100293.0 87114.0 88067.0 88759.6 88835.0 89255.0 8488.7 8780.1 8859.5 8906.6 8913.8 37515.8 37743.0 49198.5 49500.5 50443.5 63284.4 64378.7 75465.0 76001.6 77110.0 12059.5 12064.8 12125.1 12166.4 12433.8 14653.2 14868.4 15117.5 15346.2 15661.5 11528.5 14252.5 14514.8 15302.8 15306.4 14392.8 14702.4 14815.3 14949.8 15390.3 14275.1 14289.5 14594.7 14888.1 14920.0 9886.1 9988.2 10572.8 10583.4 10595.9 9829.8 9832.5 10457.2 10764.1 10795.3 11:33:04 INFO - PROCESS | 13713 | -------- Summary: end -------- 11:33:04 INFO - PROCESS | 13713 | 11:33:04 INFO - TEST-INFO | 13713: exit 0 11:33:04 INFO - TEST-OK | dromaeo_css | took 1116943ms 11:33:04 INFO - TEST-START | kraken 11:33:04 INFO - operating with platform_type : linux_ 11:33:04 INFO - Initialising browser for kraken test... 11:33:04 INFO - TEST-INFO | started process 14021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaq7N8/profile http://localhost:51692/getInfo.html) 11:33:09 INFO - PROCESS | 14021 | __metrics Screen width/height:1600/1200 11:33:09 INFO - PROCESS | 14021 | colorDepth:24 11:33:09 INFO - PROCESS | 14021 | Browser inner width/height: 1024/697 11:33:09 INFO - PROCESS | 14021 | __metrics 11:33:10 INFO - PROCESS | 14021 | 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" 11:33:10 INFO - PROCESS | 14021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:10 INFO - PROCESS | 14021 | console.error: PushService: 11:33:10 INFO - PROCESS | 14021 | stateChangeProcessEnqueue: Error transitioning state 11:33:10 INFO - PROCESS | 14021 | UnknownError 11:33:11 INFO - TEST-INFO | 14021: exit 0 11:33:11 INFO - Browser initialized. 11:33:11 INFO - Running cycle 1/1 for kraken test... 11:33:11 INFO - TEST-INFO | started process 14105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaq7N8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:23 INFO - PROCESS | 14105 | RSS: Main: 180457472 11:33:23 INFO - PROCESS | 14105 | 11:33:26 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51692/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:26 INFO - PROCESS | 14105 | RSS: Main: 242302976 11:33:26 INFO - PROCESS | 14105 | 11:33:29 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51692/tests/kraken/driver.html?testName=audio-dft) 11:33:30 INFO - PROCESS | 14105 | RSS: Main: 224874496 11:33:30 INFO - PROCESS | 14105 | 11:33:33 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51692/tests/kraken/driver.html?testName=audio-fft) 11:33:33 INFO - PROCESS | 14105 | RSS: Main: 302022656 11:33:33 INFO - PROCESS | 14105 | 11:33:35 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51692/tests/kraken/driver.html?testName=audio-oscillator) 11:33:36 INFO - PROCESS | 14105 | RSS: Main: 211714048 11:33:36 INFO - PROCESS | 14105 | 11:33:38 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:39 INFO - PROCESS | 14105 | RSS: Main: 213741568 11:33:39 INFO - PROCESS | 14105 | 11:33:42 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51692/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:42 INFO - PROCESS | 14105 | RSS: Main: 252489728 11:33:42 INFO - PROCESS | 14105 | 11:33:46 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51692/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:46 INFO - PROCESS | 14105 | RSS: Main: 251183104 11:33:46 INFO - PROCESS | 14105 | 11:33:49 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51692/tests/kraken/driver.html?testName=json-parse-financial) 11:33:50 INFO - PROCESS | 14105 | RSS: Main: 251174912 11:33:50 INFO - PROCESS | 14105 | 11:33:51 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:52 INFO - PROCESS | 14105 | RSS: Main: 213651456 11:33:52 INFO - PROCESS | 14105 | 11:33:54 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:54 INFO - PROCESS | 14105 | RSS: Main: 221077504 11:33:54 INFO - PROCESS | 14105 | 11:33:56 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:57 INFO - PROCESS | 14105 | RSS: Main: 222040064 11:33:57 INFO - PROCESS | 14105 | 11:34:00 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:00 INFO - PROCESS | 14105 | RSS: Main: 223207424 11:34:00 INFO - PROCESS | 14105 | 11:34:03 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:04 INFO - PROCESS | 14105 | RSS: Main: 221384704 11:34:04 INFO - PROCESS | 14105 | 11:34:05 INFO - PROCESS | 14105 | Cycle 1(1): loaded http://localhost:51692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51692/tests/kraken/driver.html?testName=ai-astar) 11:34:06 INFO - PROCESS | 14105 | RSS: Main: 271708160 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | __start_tp_report 11:34:06 INFO - PROCESS | 14105 | _x_x_mozilla_page_load 11:34:06 INFO - PROCESS | 14105 | _x_x_mozilla_page_load_details 11:34:06 INFO - PROCESS | 14105 | |i|pagename|runs| 11:34:06 INFO - PROCESS | 14105 | |0;ai-astar;112;109;127;110;110;111;111;112;110;111 11:34:06 INFO - PROCESS | 14105 | |1;audio-beat-detection;142;118;144;181;120;151;142;119;186;117 11:34:06 INFO - PROCESS | 14105 | |2;audio-dft;161;160;162;162;161;161;159;161;160;160 11:34:06 INFO - PROCESS | 14105 | |3;audio-fft;74;74;74;178;75;75;74;75;166;75 11:34:06 INFO - PROCESS | 14105 | |4;audio-oscillator;81;81;145;82;82;82;150;82;82;146 11:34:06 INFO - PROCESS | 14105 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 11:34:06 INFO - PROCESS | 14105 | |6;imaging-darkroom;147;147;147;147;148;146;147;146;146;146 11:34:06 INFO - PROCESS | 14105 | |7;imaging-desaturate;96;96;95;95;96;95;96;96;95;96 11:34:06 INFO - PROCESS | 14105 | |8;json-parse-financial;51;51;53;52;52;52;52;53;52;52 11:34:06 INFO - PROCESS | 14105 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;62 11:34:06 INFO - PROCESS | 14105 | |10;stanford-crypto-aes;78;79;78;79;81;79;79;79;85;78 11:34:06 INFO - PROCESS | 14105 | |11;stanford-crypto-ccm;125;130;142;123;130;123;132;130;172;134 11:34:06 INFO - PROCESS | 14105 | |12;stanford-crypto-pbkdf2;163;166;163;161;162;162;163;171;163;169 11:34:06 INFO - PROCESS | 14105 | |13;stanford-crypto-sha256-iterative;64;64;65;63;65;66;64;64;62;64 11:34:06 INFO - PROCESS | 14105 | __end_tp_report 11:34:06 INFO - PROCESS | 14105 | __start_cc_report 11:34:06 INFO - PROCESS | 14105 | _x_x_mozilla_cycle_collect,1756 11:34:06 INFO - PROCESS | 14105 | __end_cc_report 11:34:06 INFO - PROCESS | 14105 | __startTimestamp1472668446034__endTimestamp 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | ------- Summary: start ------- 11:34:06 INFO - PROCESS | 14105 | Number of tests: 14 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:5.25 (4.7%) stddev-sans-first:5.57 11:34:06 INFO - PROCESS | 14105 | Values: 112.0 109.0 127.0 110.0 110.0 111.0 111.0 112.0 110.0 111.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:143.00 stddev:25.29 (17.7%) stddev-sans-first:26.82 11:34:06 INFO - PROCESS | 14105 | Values: 142.0 118.0 144.0 181.0 120.0 151.0 142.0 119.0 186.0 117.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:34:06 INFO - PROCESS | 14105 | Values: 161.0 160.0 162.0 162.0 161.0 161.0 159.0 161.0 160.0 160.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#3] audio-fft Cycles:10 Average:94.00 Median:74.50 stddev:41.21 (55.3%) stddev-sans-first:43.07 11:34:06 INFO - PROCESS | 14105 | Values: 74.0 74.0 74.0 178.0 75.0 75.0 74.0 75.0 166.0 75.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:82.00 stddev:31.56 (38.5%) stddev-sans-first:32.61 11:34:06 INFO - PROCESS | 14105 | Values: 81.0 81.0 145.0 82.0 82.0 82.0 150.0 82.0 82.0 146.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:34:06 INFO - PROCESS | 14105 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:34:06 INFO - PROCESS | 14105 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:34:06 INFO - PROCESS | 14105 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 11:34:06 INFO - PROCESS | 14105 | Values: 51.0 51.0 53.0 52.0 52.0 52.0 52.0 53.0 52.0 52.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:34:06 INFO - PROCESS | 14105 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.18 11:34:06 INFO - PROCESS | 14105 | Values: 78.0 79.0 78.0 79.0 81.0 79.0 79.0 79.0 85.0 78.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.00 stddev:14.46 (11.0%) stddev-sans-first:14.96 11:34:06 INFO - PROCESS | 14105 | Values: 125.0 130.0 142.0 123.0 130.0 123.0 132.0 130.0 172.0 134.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:163.00 stddev:3.30 (2.0%) stddev-sans-first:3.47 11:34:06 INFO - PROCESS | 14105 | Values: 163.0 166.0 163.0 161.0 162.0 162.0 163.0 171.0 163.0 169.0 11:34:06 INFO - PROCESS | 14105 | 11:34:06 INFO - PROCESS | 14105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 11:34:06 INFO - PROCESS | 14105 | Values: 64.0 64.0 65.0 63.0 65.0 66.0 64.0 64.0 62.0 64.0 11:34:06 INFO - PROCESS | 14105 | -------- Summary: end -------- 11:34:06 INFO - PROCESS | 14105 | 11:34:07 INFO - TEST-INFO | 14105: exit 0 11:34:07 INFO - TEST-OK | kraken | took 62437ms 11:34:07 INFO - SUITE-END | took 1179s 11:34:07 INFO - Completed test suite (00:19:39) 11:34:07 INFO - javascript benchmark 11:34:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2645765016387, 3074.6156730408698, 3076.4001019801135, 3118.73490753286, 3135.858886350114, 5246.029484545362, 5301.946980530193, 5314.627976041669, 5389.757460914258, 5418.24144619753, 5413.756380962856, 5454.127339625661, 5465.07093794055, 5497.900419916023, 5504.0, 4765.8570242892765, 4856.3201151838775, 4868.391451068616, 4871.634627402959, 5057.342545469084, 4959.925601115968, 4992.950070499285, 5013.573846223076, 5018.34761481007, 5023.7236951967625, 4845.370101886768, 4849.539293767087, 4880.8047678092835, 4927.605791536668, 4986.426560945483, 4832.44426890905, 4866.878328041792, 4867.7079375237245, 4926.975365123188, 4982.352294201731, 4886.584640305578, 4902.950970490285, 4910.288008238786, 4922.33548470959, 4925.236588328815, 5303.628745987782, 5419.430959749248, 5468.425815289377, 5475.425080366544, 5504.146857237135, 5840.503557197643, 5851.0, 5868.295804503487, 5869.677167755772, 5878.853028674274, 5888.116782482662, 5895.64626122434, 5898.734556944905, 5907.527397808165, 5909.9704501477645, 5275.622541296322, 5393.19102134679, 5436.864078398072, 5443.918341224885, 5520.199571062173, 5959.970200148971, 5966.970165149233, 5968.7015649217365, 5969.671668058299, 5976.671283079472, 5715.599908006483, 5723.685197314105, 5725.198472213893, 5725.914111288334, 5729.88540229193, 5551.72241387929, 5678.886422271531, 5722.170285308607, 5730.054541000772, 5793.8841223175305, 5638.830835074954, 5693.914591281134, 5696.231008813757, 5704.828855134353, 5719.170720245541, 5676.801311954062, 5709.229254050733, 5729.570282228766, 5729.8567535811935, 5730.426957304237, 4437.267850804581, 4472.485664148599, 4516.774161291923, 4516.954830451654, 4557.475890272594, 3997.8200980955926, 4000.5199376075057, 4000.879973600797, 4001.8599349022643, 4043.433919251307, 5551.944480555224, 5553.361363443175, 5556.527695145958, 5560.193771903051, 5606.6916319602, 5642.266505354278, 5785.0454674979, 5812.79655212074, 5849.034909240013, 5911.527077833763, 5532.5020748132865, 5540.972295138498, 5547.140193270049, 5547.750351234205, 5551.444855514416, 5001.4998500149695, 5029.119904016856, 5042.621803364689, 5043.924341134886, 5097.082525145435, 5942.078977758454, 5988.431099045583, 6024.608400453956, 6032.366601506778, 6139.938600614116, 5894.38108998549, 5895.734691938787, 5897.911531326948, 5902.0, 5905.911411328748, 6014.0678194879865, 6051.697415129138, 6058.5153187745755, 6063.060225665029, 6063.939360606338, 5609.691466969356, 5612.130119831432, 5624.072028115479, 5646.322441307069, 5736.053551164011, 5734.426557344399, 5760.0783874579865, 5773.422657734193, 5773.4803867650435, 5773.711314434177, 5643.830685079454, 5653.943460565341, 5654.717264136859, 5658.122990936411, 5660.207570940154, 5610.214569960127, 5653.2085508028085, 5702.51528620072, 5713.8285851424525, 5814.04068328721, 5652.717364131695, 5655.745491452977, 5660.462256085665, 5665.0, 5676.2337084493065, 5736.4550367715, 5765.077587586134, 5769.798057067983, 5775.9133612996675, 5776.306843178677, 5438.619296649196, 5554.861128471821, 5564.443555644403, 5609.046462101371, 5643.097104463266], "value": 5354.08942599684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8580958836637, 591.0720169334146, 602.9698515074246, 620.4230066038585, 629.0312918106117, 42223.155536889244, 43979.56020439799, 44070.559294407045, 44685.55314446855, 44832.0, 42312.788436057774, 45854.77072614641, 45970.31044534335, 45979.31031034537, 46006.0, 8105.837883242331, 9033.728988130366, 9181.816363672722, 9187.999999999967, 10721.83917241242, 10511.63209287675, 10926.235163538555, 10929.234953553254, 10934.781304373908, 10940.4529773511, 10923.071538919201, 10978.505967231455, 11005.284656497342, 11011.174161937846, 11012.39431831249, 10886.782264354708, 10959.616413425572, 10966.835497467544, 10984.06635435989, 10984.945075274652, 10798.51406686701, 10883.78232435347, 10886.945565272123, 10888.67333979974, 10891.891081089247, 42845.35731964023, 43225.13549729019, 43306.0, 43307.35038974418, 43366.0, 3494.5806503219524, 3495.9300813983577, 3530.5410296661526, 3572.6427357264324, 3642.927141457156, 32428.189295267806, 32597.511037334458, 33366.3326733464, 33710.49434258488, 34732.0, 4299.957000429987, 4345.782710864444, 4366.170427618742, 4371.30059190528, 4443.289073748185, 345014.0, 345140.0, 346930.0, 347023.2648836765, 347043.0, 58380.0, 58697.413025870046, 58797.70601146967, 58837.70581147067, 58888.0, 61080.38919610836, 61334.693326533976, 61436.0, 61494.0, 61506.384936150964, 14506.0, 14613.123212607064, 14642.853571464362, 14687.632809179857, 14725.19011454359, 11455.713607159887, 11617.244879082833, 11639.359835208976, 11656.766864662659, 11664.475098620582, 15682.0, 16628.750568741478, 16835.0, 16940.91529542369, 16987.320507179822, 6049.243844519435, 6092.116643086728, 6117.204763380821, 6223.782167624111, 6251.718672659741, 962.8459446488669, 1006.7885743993843, 1022.4734261855151, 1077.342820879263, 1093.6117678224116, 32467.0, 32491.18772030718, 32627.347453050807, 33075.50386744153, 33618.0, 1091.82530795074, 1101.2236373356764, 1101.7741363020561, 1114.7436089699415, 1120.6638008597552, 16311.918440407722, 17097.58423236103, 17100.144992750313, 17210.0, 17449.38927137544, 497363.0, 499418.0, 501569.0, 507188.0, 510875.0, 59618.9514415557, 59825.0, 60021.0, 60064.69967650134, 60129.69935150296, 1262.873712628748, 1289.4390939940968, 1323.1399590266403, 1333.379978310071, 1349.9460021599223, 30390.848045760515, 31438.0, 32362.821948489072, 32602.83698581492, 33045.17387065342, 51670.74164629153, 51889.48110518847, 51911.48088519218, 52096.47903521068, 52142.47857521528, 430335.0, 431126.0, 431763.0, 432090.0, 432589.0, 33758.662413375554, 34423.31153376969, 41454.585454145075, 41895.371569427094, 42463.787681061396, 46925.76537117293, 47529.28706069342, 47708.284375735086, 47950.0, 48144.27783583179, 40020.399694005195, 40305.74086816056, 40364.3945340826, 41438.79280603577, 42844.0, 39541.40687889626, 39809.0, 40288.79855600703, 41501.792491037355, 41758.0, 39776.63658573043, 41123.0, 41379.0, 41519.792401037805, 41529.58470415257, 32412.675873241908, 35561.64438355583, 35933.460998085575, 36360.27279454449, 37690.24619507649, 28049.57925631158, 28327.43345133127, 28369.574456383583, 28403.0, 28453.0], "value": 20527.59934192994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4780854612088, 377.4074702716734, 410.37417937645085, 412.13657387772616, 418.493622716513, 14235.288235588205, 17311.740323895152, 18068.457946261617, 19573.119209635566, 19617.901910490444, 17922.462326130204, 17945.551361215978, 18545.44363669092, 19408.708869366936, 19520.121594528246, 5555.833325000256, 5746.0806270996645, 5747.568932330071, 5765.1352297155345, 5774.769009239625, 4120.649744771698, 5644.096944488882, 5708.942910570903, 6139.938600613981, 6441.162648855642, 6328.588641738295, 6423.550351475398, 6435.967820160892, 6440.033994900756, 6440.13058237139, 6132.386761323876, 6273.184486016811, 6296.024116261987, 6309.3690630937, 6313.337099604544, 5520.420355862617, 5598.44015598441, 5599.832005039855, 5607.158926161068, 5608.579356548275, 23101.884490577606, 23354.416139596648, 23467.765322346728, 23488.412789680224, 23667.0, 2345.6950596422357, 2352.6472278439965, 2443.6823212982376, 2600.375909781658, 2897.898573549937, 13955.511557095453, 14670.19313937733, 14805.481808136663, 14819.77770333446, 15381.230938453144, 1856.2574970011967, 1904.4001139640968, 1911.3788018893777, 1960.2257108442086, 1991.08306331224, 80150.0, 81045.59477202635, 81470.59264703697, 83306.0, 83345.58327208385, 10590.922494839388, 10790.838137427945, 10876.673699789018, 11111.49991251978, 11143.567892416508, 15496.0, 15510.922445387701, 15514.301856416489, 15533.378664853279, 15578.143202123993, 7726.497777644435, 7812.804679882935, 8017.358611311081, 8098.31164351025, 8121.715739949192, 7195.820104497429, 7225.819354516179, 7234.348908598251, 7432.368248698921, 7439.628018599048, 6413.422791948747, 6523.902141467882, 6645.435138013323, 6695.765648202387, 6800.693968771318, 1887.584731359099, 1909.76127984002, 1947.931822386238, 1958.735570697966, 1985.4936991067475, 847.2132451648237, 940.167951363035, 950.6957773512548, 969.2391472693902, 995.3082607587658, 20046.89976550108, 20125.39623811288, 20241.797582024286, 20325.390238292875, 20396.796032039787, 964.8070385922844, 968.6270785747538, 991.9454430006275, 1010.1767059846349, 1030.253066526777, 11087.05760010408, 11298.943505282585, 11353.716157095974, 11380.146489013357, 11388.0, 483018.0, 494336.0, 496632.0, 498512.0, 504556.0, 97100.51449742707, 100495.49752251191, 104065.0, 104971.0277523634, 106153.46923265334, 1038.5430410619304, 1048.1719441641171, 1052.6157952347492, 1058.5448257249457, 1083.9945800270948, 17217.225224864662, 17387.739183912505, 17900.641987159925, 18099.54751131232, 18373.63252734911, 28382.43235135327, 33481.16297092592, 41928.0, 42530.0, 42846.57153428426, 55620.443795563144, 56173.43826561682, 57576.71211643915, 62636.0, 63386.0, 7528.4353673473615, 7647.694092236248, 7839.33365663925, 7948.244916733132, 7985.480943738638, 11414.657560273205, 12543.623691289276, 13158.934205329295, 13358.131721438076, 13597.252151131783, 11381.203315767816, 11484.310941343547, 11675.76648467009, 11792.23350482216, 12306.200096993667, 11197.776044479227, 11569.710757231136, 11580.42097895085, 11663.76672466563, 12235.143539952118, 10922.726931826768, 11194.776104477702, 11495.367754773568, 11628.709282268012, 12352.197107188003, 7711.922880771121, 7841.490303130278, 7877.133515313426, 7928.524288542706, 8197.947788000862, 11294.60468883585, 11561.265810128549, 11632.76734465289, 11710.88289117132, 11756.82364764512], "value": 9402.833433334243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.3105119812103, 1472.5435115114315, 1503.2033022498076, 1632.738761798112, 1812.8912265264078, 8721.127887211283, 8887.155720206578, 8914.375993680445, 9179.036201198878, 9184.12750788674, 8799.0, 8965.775855603613, 8967.551622418885, 8979.057198994109, 8993.055729148444, 2090.6341390256644, 2296.1389478945393, 2383.1301574925155, 2425.5391475619663, 2430.9756902431013, 2375.2874137758604, 2401.7478164792706, 2407.9398015049587, 2409.8915548800346, 2411.6744239527616, 2293.6444851048113, 2299.4941112955207, 2345.108858633717, 2390.40239940015, 2394.389430695179, 2299.4366380236947, 2346.073301046086, 2357.24568138195, 2370.4903445759246, 2378.988105059481, 2329.5690297294886, 2362.11420717231, 2372.79831214347, 2374.204641445118, 2375.869327187004, 9057.320700947455, 9129.634814607407, 9139.954300228523, 9144.40561363516, 9145.634174633007, 5237.319148510669, 5354.919676204821, 5380.085385484438, 5426.023315803154, 5434.619576629638, 3312.635610082889, 3492.3539145257955, 3534.2754735279204, 3534.787912725219, 3539.43369060949, 1142.7200335917753, 1194.796884529632, 1201.447334226257, 1221.6579357779835, 1241.3172754984723, 12499.375031248492, 12746.362681865963, 12747.61757147287, 12778.744425111445, 12818.935905320506, 4375.146846364928, 4592.931106033412, 4661.463931647904, 4697.8355757548325, 4784.665073444895, 10685.786284274427, 10702.571897124184, 10704.94647526773, 10717.035466808025, 10719.249652524248, 5308.097623403954, 5327.38735045467, 5335.093034184198, 5335.759890804923, 5339.652922560022, 4364.54172311909, 4767.856964291077, 4852.272159176152, 4892.535209155125, 4897.755112244374, 3990.521137463523, 4040.41413994975, 4143.647789937889, 4188.267053265667, 4196.139791342767, 1276.6553030681664, 1279.1730276089945, 1299.7270573179549, 1312.8424589049375, 1320.7556602028656, 904.1771987491351, 906.5875026862761, 937.6765016069445, 938.5166639180827, 968.4963818814177, 5698.971505142447, 5822.097574875901, 5902.585376324755, 5911.0, 5941.643501389931, 448.30960321105135, 451.51687694166924, 453.38339857793375, 455.28065656263027, 457.78941686823765, 3928.5482169550296, 3971.960280397159, 3988.3219852625125, 4034.23349563582, 4072.75563466193, 11142.331460112418, 11426.2001659883, 11514.76970460603, 11522.884771152181, 11532.596359127558, 11425.0, 11425.08599312053, 11444.885551144549, 11446.313221206754, 11467.31196128235, 8342.207490288412, 8399.496030238206, 8418.494890306602, 8500.872486912702, 8513.489190648457, 5709.314882214161, 5716.714164291852, 5738.598298119258, 5776.480116789509, 5804.941950580609, 10270.537825798006, 10353.4305613192, 10416.583336666448, 10445.9477702611, 10521.526531305957, 9984.101430871257, 10369.377837329785, 10372.740681483023, 10553.472326383804, 10675.89324106749, 7461.850762984602, 7925.0, 7938.841223175619, 8116.472429292077, 8137.389695772722, 8807.735767926972, 8995.23540499065, 8995.91004089977, 9002.0, 9002.0, 7938.960305198668, 8123.837523249384, 8138.633761480866, 8277.255047045795, 8382.706605268786, 7896.7236146734585, 8009.8398032040195, 8013.038435387791, 8141.307988821017, 8253.33973282148, 7035.542689725152, 7342.816429589303, 7402.259774022555, 7461.664225109775, 7471.738489152854, 5299.735013249399, 5311.203319502106, 5370.597205209547, 5401.2168235606405, 5519.917201242065, 5355.651882627617, 5361.812336568201, 5370.301860758076, 5370.731463426735, 5405.918911216414], "value": 4649.204253946456, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.8248510774397, 341.0631114615934, 341.62933217459056, 347.9930401391971, 350.3448551209239, 5372.4090350061515, 5384.903680383775, 5399.865003374913, 5401.108817045193, 5409.404965453802, 5273.973630131844, 5310.6017048721405, 5335.186036747505, 5350.117230656937, 5362.82017956049, 3922.529296484419, 4002.459667944819, 4129.772862492577, 4150.3359462486005, 4153.460050193471, 4123.938030984507, 4137.937930931039, 4139.8965025874295, 4159.896002599929, 4179.540250572434, 4100.261952848486, 4121.278776214151, 4127.0, 4127.380892866064, 4142.71001029928, 3890.1636148228126, 3930.5872883347265, 4131.669466442708, 4164.8542301019315, 4169.124483858393, 3667.0832291927018, 3689.3912504436735, 3696.316181506403, 3701.2782507411066, 3706.5737440194453, 5151.871203219912, 5159.948400515985, 5161.870953226162, 5186.7147306898105, 5186.818461353834, 4462.843800466968, 4651.348811166439, 4678.3216433616935, 4684.344191813149, 4743.430788305391, 5448.575383954142, 5450.4549545045575, 5462.562994960434, 5464.754086066137, 5466.617336786427, 3963.5243770747693, 4000.9399859002137, 4001.7198796084285, 4001.8599349022643, 4013.57857424972, 5502.80740174092, 5640.0, 5659.009673307196, 5691.345495268014, 5697.0, 4057.5333836609166, 4062.289099407592, 4064.8170832312617, 4069.715119941635, 4083.6528895044253, 4150.792460376969, 4169.395437661522, 4173.8956526087095, 4195.286801243796, 4195.496540415109, 4651.651126165551, 4713.976430117896, 4754.809807607726, 4758.476567577563, 4775.21209000511, 5510.614257002052, 5516.779328826882, 5529.806456774074, 5543.616245014602, 5590.440955904377, 1358.7758019926798, 1361.8229630148016, 1370.7943808428815, 1371.430856194688, 1374.3677908162158, 878.5563290538365, 899.0, 912.5118061836886, 931.8136372725346, 945.933784635069, 5201.583873290203, 5306.612024588951, 5376.973115134399, 5390.652336915771, 5418.783248670009, 5628.97185514078, 5638.605297629127, 5670.0, 5683.067756962652, 5690.800821971211, 5193.7403129844115, 5327.520523152934, 5353.625246232804, 5359.998400895511, 5361.08861493547, 2948.758943203181, 2958.7189217024347, 2968.7773416993814, 2972.0043785331723, 2983.34366439383, 5769.278840144982, 5801.506871915934, 5815.563832712479, 5818.5345172386105, 5823.660558071582, 5395.433479484597, 5607.186957891165, 5638.2670252866865, 5660.349059858087, 5674.432556744375, 5739.454751798572, 5754.280714910637, 5811.564132690065, 5817.004242814954, 5863.17915491823, 5382.3541175059245, 5561.694106824163, 5646.0, 5651.6043876928225, 5672.574556908331, 5587.357453892854, 5597.3412629000895, 5614.294565586693, 5624.437556244507, 5635.182898479779, 5774.624649397776, 5790.189373487631, 5814.680192589448, 5824.883502330014, 5842.38654941242, 3925.7644541327613, 4004.9574716894012, 4066.512018557674, 4086.9795651021554, 4088.570700076449, 5645.294338207724, 5646.35066967304, 5652.152177173457, 5661.405552416937, 5682.602217844877, 5529.364123125731, 5557.249771280825, 5562.969516126665, 5580.330360356783, 5584.413636568264, 5223.373195216598, 5417.864553386197, 5500.70733377648, 5503.972480137734, 5509.3664228612615, 5440.53755430777, 5448.291722076105, 5453.182022696627, 5461.617686761889, 5468.972655136698, 5269.262303277467, 5334.653247538898, 5533.142362933751, 5540.196671482693, 5558.776489404109, 5441.428649991693, 5445.292112025411, 5457.399686034453, 5458.536024437967, 5460.672359658433], "value": 4214.5529572961905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.636074225485, 785.3952456608412, 803.5178892664399, 809.7768647940574, 819.7212947597816, 15540.689186216268, 16339.18304084797, 16724.498265052036, 16808.0, 16896.32414703412, 14670.559883203494, 14927.32827022784, 15028.774568381456, 15060.924695376536, 15061.246937653128, 783.8824176373547, 787.1970589998199, 794.146292735309, 794.4041968523608, 796.1958421993799, 650.8015055408099, 774.5004472115482, 796.7131832540281, 806.4717609965483, 808.4219782855257, 859.1151114352227, 860.101194252005, 861.6294993152973, 862.0861886400404, 862.1464749897619, 848.6562942008496, 848.898132224134, 848.9787755306105, 849.3375167369462, 849.5794581682076, 500.8622628777079, 594.2245369792419, 605.449041372349, 609.3784339973247, 624.307019208678, 13073.215607063607, 13109.344532773322, 13111.0, 13116.081874268804, 13119.934400328033, 13579.253141077237, 14184.716305673828, 14221.0, 14253.358598863077, 14440.638984025378, 12883.871161288454, 13094.148880322844, 13156.802647960192, 13166.670833229151, 13313.26777027263, 4331.393604895317, 4348.21732088224, 4404.361367601679, 4409.294512877924, 4588.49526552079, 79957.60021199915, 80687.0, 80899.19100808975, 82238.58880705618, 83558.58220708919, 10964.451777411097, 11028.889711102947, 11082.90440257855, 11130.554777808797, 11226.0, 19344.226230950604, 19421.805781942283, 19545.120469578902, 19559.0220488975, 19590.412287631392, 7265.818354541178, 7321.74373896911, 7350.889736653954, 7370.373518251009, 7491.363234125051, 4358.193734159191, 4385.429894113745, 4623.12160689468, 4660.997885454643, 4686.203345431285, 3330.400527905, 3434.055634700477, 3464.72282217422, 3471.7743346682387, 3472.444408894615, 622.1255130804591, 631.311870061635, 632.8357018995048, 637.1462240597622, 653.9607623542603, 664.3489380407228, 669.6517810738388, 675.9391654751096, 679.8164495586165, 696.5263620737845, 8495.787605309793, 8796.648134074694, 8816.515091669891, 8876.334274929406, 8909.43160524672, 635.6980434293766, 655.3053763011224, 671.8857794175002, 675.1965161457849, 703.7818276334352, 4248.596383343577, 4416.381706561084, 4453.332000199931, 4471.306947423154, 4473.932891006638, 91072.0, 116781.96487991743, 118661.40669296599, 123003.0, 126644.36677816552, 59264.0, 60003.0, 61049.69475152596, 84339.57830210932, 100293.0, 87114.0, 88067.0, 88759.55620221858, 88835.0, 89255.0, 8488.74533763988, 8780.146452403122, 8859.468431894107, 8906.643734250816, 8913.777155570902, 37515.81242093772, 37743.0, 49198.50801491939, 49500.50499494959, 50443.49556504535, 63284.36715632785, 64378.678106609164, 75465.0, 76001.61999189969, 77110.0, 12059.51761929513, 12064.75870482568, 12125.090618203494, 12166.39168041612, 12433.751324973631, 14653.194074326015, 14868.40526378976, 15117.54647360581, 15346.23268836576, 15661.530154095395, 11528.481218345027, 14252.501162459264, 14514.782278266046, 15302.846971530587, 15306.387744490095, 14392.82453943628, 14702.411903524167, 14815.333310001291, 14949.83227432038, 15390.307436165176, 14275.14349139055, 14289.472247452431, 14594.708105838035, 14888.106713596786, 14920.0, 9886.060824221688, 9988.200943924323, 10572.788544229226, 10583.417912014605, 10595.894041059491, 9829.803403932025, 9832.459214743258, 10457.215708821717, 10764.138868890626, 10795.32783919979], "value": 7356.004986373821, "unit": "score"}], "name": "dromaeo_css", "value": 7280.873003623843, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 127.0, 110.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 144.0, 181.0, 120.0, 151.0, 142.0, 119.0, 186.0, 117.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 161.0, 159.0, 161.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 178.0, 75.0, 75.0, 74.0, 75.0, 166.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 145.0, 82.0, 82.0, 82.0, 150.0, 82.0, 82.0, 146.0], "value": 101.3, "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": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 79.0, 81.0, 79.0, 79.0, 79.0, 85.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 142.0, 123.0, 130.0, 123.0, 132.0, 130.0, 172.0, 134.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 161.0, 162.0, 162.0, 163.0, 171.0, 163.0, 169.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 65.0, 66.0, 64.0, 64.0, 62.0, 64.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1525.4999999999998, "alertThreshold": 2.0}]} 11:34:07 INFO - Return code: 0 11:34:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:34:07 INFO - # TBPL SUCCESS # 11:34:07 INFO - Running post-action listener: _resource_record_post_action 11:34:07 INFO - [mozharness: 2016-08-31 18:34:07.862134Z] Finished run-tests step (success) 11:34:07 INFO - Running post-run listener: _resource_record_post_run 11:34:07 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 423485440; Read time: 0; Write time: 405552 11:34:07 INFO - TinderboxPrint: CPU usage
13.1% 11:34:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:34:07 INFO - TinderboxPrint: I/O write bytes / time
423,485,440 / 405,552 11:34:07 INFO - TinderboxPrint: CPU idle
8,309.0 (86.9%) 11:34:07 INFO - TinderboxPrint: CPU user
1,196.7 (12.5%) 11:34:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 134701056; Read time: 0; Write time: 154020 11:34:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288366592; Read time: 0; Write time: 251432 11:34:08 INFO - Running post-run listener: _upload_blobber_files 11:34:08 INFO - Blob upload gear active. 11:34:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:08 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 11:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:34:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:09 INFO - (blobuploader) - INFO - Done attempting. 11:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:13 INFO - (blobuploader) - INFO - Done attempting. 11:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:13 INFO - (blobuploader) - INFO - Done attempting. 11:34:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:13 INFO - Return code: 0 11:34:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7af699a085a8ece5a6fd7feeed2524b79818fc8a7283fdf183e1a7e3bb156b7d3dbc139748257919bf28b7687bd634f5b754bcddc6f15afa65de03e1fc52970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb7e9cdba2d8eeb7a2c1bc2fb420a7a553275efc56b328b30af281d6fd972d67afadcc335d5ced9e2220054163133fd5144f4738eed0c9a14df0cde511a8848", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59efbbf636bcb78bb4feb2b14743492d096687682de63afa604f56e69a4acd30ec1d2b3ceae5b4233f7e5c0b43256b4e2edda4e7edb4bdbf07f2e13459c0852"} 11:34:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:13 INFO - Contents: 11:34:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7af699a085a8ece5a6fd7feeed2524b79818fc8a7283fdf183e1a7e3bb156b7d3dbc139748257919bf28b7687bd634f5b754bcddc6f15afa65de03e1fc52970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb7e9cdba2d8eeb7a2c1bc2fb420a7a553275efc56b328b30af281d6fd972d67afadcc335d5ced9e2220054163133fd5144f4738eed0c9a14df0cde511a8848", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59efbbf636bcb78bb4feb2b14743492d096687682de63afa604f56e69a4acd30ec1d2b3ceae5b4233f7e5c0b43256b4e2edda4e7edb4bdbf07f2e13459c0852"} 11:34:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:13 INFO - Copying logs to upload dir... 11:34:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.237172 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-31 11:34:11.259762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:34:11.263166) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7af699a085a8ece5a6fd7feeed2524b79818fc8a7283fdf183e1a7e3bb156b7d3dbc139748257919bf28b7687bd634f5b754bcddc6f15afa65de03e1fc52970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb7e9cdba2d8eeb7a2c1bc2fb420a7a553275efc56b328b30af281d6fd972d67afadcc335d5ced9e2220054163133fd5144f4738eed0c9a14df0cde511a8848", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59efbbf636bcb78bb4feb2b14743492d096687682de63afa604f56e69a4acd30ec1d2b3ceae5b4233f7e5c0b43256b4e2edda4e7edb4bdbf07f2e13459c0852"} build_url:https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/EF-f0OFFRoOYWuyOqYkTAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7af699a085a8ece5a6fd7feeed2524b79818fc8a7283fdf183e1a7e3bb156b7d3dbc139748257919bf28b7687bd634f5b754bcddc6f15afa65de03e1fc52970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb7e9cdba2d8eeb7a2c1bc2fb420a7a553275efc56b328b30af281d6fd972d67afadcc335d5ced9e2220054163133fd5144f4738eed0c9a14df0cde511a8848", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59efbbf636bcb78bb4feb2b14743492d096687682de63afa604f56e69a4acd30ec1d2b3ceae5b4233f7e5c0b43256b4e2edda4e7edb4bdbf07f2e13459c0852"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 11:34:11.291217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:34:11.291756) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1472667028.680573-1511083051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 11:34:11.375083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:34:11.375460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 11:34:11.375823) ========= ========= Total master_lag: 0.24 =========