builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1472192304.78 results: success (0) buildid: 20160825203011 builduid: 6f1615d2cbfb4134803a5d280488706f revision: b7e8b15d90da87ca0491b9515ca8640f97ef132e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.783724) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.784458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.784910) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.818263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.818539) ========= 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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 23:18:24-- 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% 38.6M=0s 2016-08-25 23:18:25 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.939246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.939528) ========= 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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:24.989095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 23:18:24.989482) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7e8b15d90da87ca0491b9515ca8640f97ef132e --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 b7e8b15d90da87ca0491b9515ca8640f97ef132e --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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 23:18:25,168 truncating revision to first 12 chars 2016-08-25 23:18:25,168 Setting DEBUG logging. 2016-08-25 23:18:25,168 attempt 1/10 2016-08-25 23:18:25,168 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7e8b15d90da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 23:18:26,463 unpacking tar archive at: fx-team-b7e8b15d90da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.823778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 23:18:26.829512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:26.830262) ========= script_repo_revision: b7e8b15d90da87ca0491b9515ca8640f97ef132e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:26.831081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:26.831522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 23:18:26.841758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 23:18:26.842113) ========= /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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:18:27 INFO - MultiFileLogger online at 20160825 23:18:27 in /builds/slave/test 23:18:27 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 23:18:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:18:27 INFO - {'append_to_log': False, 23:18:27 INFO - 'base_work_dir': '/builds/slave/test', 23:18:27 INFO - 'blob_upload_branch': 'Fx-Team', 23:18:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:18:27 INFO - 'branch': 'Fx-Team', 23:18:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:18:27 INFO - 'config_files': ('talos/linux_config.py',), 23:18:27 INFO - 'default_actions': ('clobber', 23:18:27 INFO - 'read-buildbot-config', 23:18:27 INFO - 'download-and-extract', 23:18:27 INFO - 'populate-webroot', 23:18:27 INFO - 'create-virtualenv', 23:18:27 INFO - 'install', 23:18:27 INFO - 'run-tests'), 23:18:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:18:27 INFO - 'download_minidump_stackwalk': True, 23:18:27 INFO - 'download_symbols': 'ondemand', 23:18:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:18:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:18:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:18:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:18:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:18:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:18:27 INFO - 'installer_path': 'installer.exe', 23:18:27 INFO - 'log_level': 'info', 23:18:27 INFO - 'log_name': 'talos', 23:18:27 INFO - 'log_to_console': True, 23:18:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:18:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:18:27 INFO - 'opt_config_files': (), 23:18:27 INFO - 'pip_index': False, 23:18:27 INFO - 'sps_profile': False, 23:18:27 INFO - 'sps_profile_interval': 0, 23:18:27 INFO - 'suite': 'dromaeojs', 23:18:27 INFO - 'system_bits': '32', 23:18:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:18:27 INFO - 'title': 'talos-linux64-ix-046', 23:18:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:18:27 INFO - 'use_talos_json': True, 23:18:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:18:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:18:27 INFO - 'work_dir': 'build'} 23:18:27 INFO - [mozharness: 2016-08-26 06:18:27.118669Z] Running clobber step. 23:18:27 INFO - Running pre-action listener: _resource_record_pre_action 23:18:27 INFO - Running main action method: clobber 23:18:27 INFO - rmtree: /builds/slave/test/build 23:18:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:18:27 INFO - Running post-action listener: _resource_record_post_action 23:18:27 INFO - [mozharness: 2016-08-26 06:18:27.575721Z] Finished clobber step (success) 23:18:27 INFO - [mozharness: 2016-08-26 06:18:27.575822Z] Running read-buildbot-config step. 23:18:27 INFO - Running pre-action listener: _resource_record_pre_action 23:18:27 INFO - Running main action method: read_buildbot_config 23:18:27 INFO - Using buildbot properties: 23:18:27 INFO - { 23:18:27 INFO - "project": "", 23:18:27 INFO - "product": "firefox", 23:18:27 INFO - "script_repo_revision": "production", 23:18:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:18:27 INFO - "repository": "", 23:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:18:27 INFO - "buildid": "20160825203011", 23:18:27 INFO - "pgo_build": "True", 23:18:27 INFO - "basedir": "/builds/slave/test", 23:18:27 INFO - "buildnumber": 392, 23:18:27 INFO - "slavename": "talos-linux64-ix-046", 23:18:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:18:27 INFO - "platform": "ubuntu64_hw", 23:18:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:18:27 INFO - "branch": "fx-team", 23:18:27 INFO - "repo_path": "integration/fx-team", 23:18:27 INFO - "revision": "b7e8b15d90da87ca0491b9515ca8640f97ef132e", 23:18:27 INFO - "stage_platform": "linux64-pgo", 23:18:27 INFO - "builduid": "6f1615d2cbfb4134803a5d280488706f", 23:18:27 INFO - "slavebuilddir": "test" 23:18:27 INFO - } 23:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:18:27 INFO - Running post-action listener: _resource_record_post_action 23:18:27 INFO - [mozharness: 2016-08-26 06:18:27.578296Z] Finished read-buildbot-config step (success) 23:18:27 INFO - [mozharness: 2016-08-26 06:18:27.578385Z] Running download-and-extract step. 23:18:27 INFO - Running pre-action listener: _resource_record_pre_action 23:18:27 INFO - Running main action method: download_and_extract 23:18:27 INFO - mkdir: /builds/slave/test/build/tests 23:18: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')]} 23:18:27 INFO - trying https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:28 INFO - Downloaded 1361 bytes. 23:18:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:18:28 INFO - Using the following test package requirements: 23:18:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:18:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:18:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:18:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'jsshell-linux-x86_64.zip'], 23:18:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:18:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:18:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:18:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:18:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:18:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:18:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:18:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:28 INFO - trying https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:28 INFO - Downloaded 21872712 bytes. 23:18:28 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 23:18:33 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 23:18: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')]} 23:18:33 INFO - trying https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:18:33 INFO - Downloading https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:34 INFO - Downloaded 21872712 bytes. 23:18:34 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 23:18:38 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')]} 23:18:38 INFO - trying https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:18:38 INFO - Downloading https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:39 INFO - Downloaded 14413981 bytes. 23:18:39 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 23:18: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')]} 23:18:39 INFO - trying https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:18:39 INFO - Downloading https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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 23:18:40 INFO - Downloaded 59826660 bytes. 23:18:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:18:40 INFO - mkdir: /builds/slave/test/properties 23:18:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:18:40 INFO - Writing to file /builds/slave/test/properties/build_url 23:18:40 INFO - Contents: 23:18:40 INFO - build_url:https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:18:41 INFO - Running post-action listener: _resource_record_post_action 23:18:41 INFO - Running post-action listener: set_extra_try_arguments 23:18:41 INFO - [mozharness: 2016-08-26 06:18:41.437104Z] Finished download-and-extract step (success) 23:18:41 INFO - [mozharness: 2016-08-26 06:18:41.437330Z] Running populate-webroot step. 23:18:41 INFO - Running pre-action listener: _resource_record_pre_action 23:18:41 INFO - Running main action method: populate_webroot 23:18:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:18:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:18:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:18:41 INFO - '--tppagecycles', 23:18:41 INFO - '7'], 23:18:41 INFO - 'tests': ['tsvgm']}}, 23:18:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:18:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:18:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:18:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:18:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['damp', 'tps']}, 23:18:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'tests': ['damp', 'tps']}, 23:18:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['dromaeo_dom']}, 23:18:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:18:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['basic_compositor_video']}, 23:18:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:18:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'other-e10s': {'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['a11yr', 23:18:41 INFO - 'ts_paint', 23:18:41 INFO - 'tpaint', 23:18:41 INFO - 'sessionrestore', 23:18:41 INFO - 'sessionrestore_no_auto_restore', 23:18:41 INFO - 'tabpaint']}, 23:18:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['tsvgx', 23:18:41 INFO - 'tsvgr_opacity', 23:18:41 INFO - 'tart', 23:18:41 INFO - 'tscrollx', 23:18:41 INFO - 'cart']}, 23:18:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:18:41 INFO - 'tsvgr_opacity', 23:18:41 INFO - 'tart', 23:18:41 INFO - 'tscrollx', 23:18:41 INFO - 'cart']}, 23:18:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'talos_options': ['--disable-e10s'], 23:18:41 INFO - 'tests': ['tp5o']}, 23:18:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'tests': ['tp5o']}, 23:18:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'talos_options': ['--disable-e10s', 23:18:41 INFO - '--xperf_path', 23:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:41 INFO - 'tests': ['tp5n']}, 23:18:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:41 INFO - 'talos_options': ['--xperf_path', 23:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:41 INFO - 'tests': ['tp5n']}}, 23:18:41 INFO - 'talos.zip': {'path': '', 23:18:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:18:41 INFO - Running post-action listener: _resource_record_post_action 23:18:41 INFO - [mozharness: 2016-08-26 06:18:41.455847Z] Finished populate-webroot step (success) 23:18:41 INFO - [mozharness: 2016-08-26 06:18:41.455936Z] Running create-virtualenv step. 23:18:41 INFO - Running pre-action listener: _resource_record_pre_action 23:18:41 INFO - Running main action method: create_virtualenv 23:18:41 INFO - Creating virtualenv /builds/slave/test/build/venv 23:18:41 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 23:18:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:18:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:18:41 INFO - Using real prefix '/usr' 23:18:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:18:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:18:44 INFO - Installing pip.................done. 23:18:44 INFO - Return code: 0 23:18:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:44 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:44 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 23:18:44 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 23:18:44 INFO - Using env: {'DISPLAY': ':0', 23:18:44 INFO - 'HOME': '/home/cltbld', 23:18:44 INFO - 'LANG': 'en_US.UTF-8', 23:18:44 INFO - 'LANGUAGE': 'en_US:en', 23:18:44 INFO - 'LOGNAME': 'cltbld', 23:18:44 INFO - 'MAIL': '/var/mail/cltbld', 23:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:44 INFO - 'MOZ_NO_REMOTE': '1', 23:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:44 INFO - 'NO_EM_RESTART': '1', 23:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:44 INFO - 'PWD': '/builds/slave/test', 23:18:44 INFO - 'SHELL': '/bin/bash', 23:18:44 INFO - 'SHLVL': '1', 23:18:44 INFO - 'TERM': 'linux', 23:18:44 INFO - 'TMOUT': '86400', 23:18:44 INFO - 'USER': 'cltbld', 23:18:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:44 INFO - '_': '/tools/buildbot/bin/python'} 23:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:44 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 23:18:44 INFO - Cleaning up... 23:18:44 INFO - Return code: 0 23:18:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:44 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:44 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 23:18:44 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 23:18:44 INFO - Using env: {'DISPLAY': ':0', 23:18:44 INFO - 'HOME': '/home/cltbld', 23:18:44 INFO - 'LANG': 'en_US.UTF-8', 23:18:44 INFO - 'LANGUAGE': 'en_US:en', 23:18:44 INFO - 'LOGNAME': 'cltbld', 23:18:44 INFO - 'MAIL': '/var/mail/cltbld', 23:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:44 INFO - 'MOZ_NO_REMOTE': '1', 23:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:44 INFO - 'NO_EM_RESTART': '1', 23:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:44 INFO - 'PWD': '/builds/slave/test', 23:18:44 INFO - 'SHELL': '/bin/bash', 23:18:44 INFO - 'SHLVL': '1', 23:18:44 INFO - 'TERM': 'linux', 23:18:44 INFO - 'TMOUT': '86400', 23:18:44 INFO - 'USER': 'cltbld', 23:18:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:44 INFO - '_': '/tools/buildbot/bin/python'} 23:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:44 INFO - Downloading/unpacking psutil>=3.1.1 23:18:44 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 23:18:44 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 23:18:44 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 23:18:44 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 23:18:44 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 23:18:44 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 23:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:46 INFO - Installing collected packages: psutil 23:18:46 INFO - Running setup.py install for psutil 23:18:46 INFO - building 'psutil._psutil_linux' extension 23:18:46 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 23:18:46 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 23:18:46 INFO - building 'psutil._psutil_posix' extension 23:18:46 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 23:18:46 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 23:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:46 INFO - Successfully installed psutil 23:18:46 INFO - Cleaning up... 23:18:47 INFO - Return code: 0 23:18:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:47 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:47 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 23:18:47 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 23:18:47 INFO - Using env: {'DISPLAY': ':0', 23:18:47 INFO - 'HOME': '/home/cltbld', 23:18:47 INFO - 'LANG': 'en_US.UTF-8', 23:18:47 INFO - 'LANGUAGE': 'en_US:en', 23:18:47 INFO - 'LOGNAME': 'cltbld', 23:18:47 INFO - 'MAIL': '/var/mail/cltbld', 23:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:47 INFO - 'MOZ_NO_REMOTE': '1', 23:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:47 INFO - 'NO_EM_RESTART': '1', 23:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:47 INFO - 'PWD': '/builds/slave/test', 23:18:47 INFO - 'SHELL': '/bin/bash', 23:18:47 INFO - 'SHLVL': '1', 23:18:47 INFO - 'TERM': 'linux', 23:18:47 INFO - 'TMOUT': '86400', 23:18:47 INFO - 'USER': 'cltbld', 23:18:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:47 INFO - '_': '/tools/buildbot/bin/python'} 23:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:18:47 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 23:18:47 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 23:18:47 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 23:18:47 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 23:18:47 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 23:18:47 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 23:18:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:18:49 INFO - Installing collected packages: mozsystemmonitor 23:18:49 INFO - Running setup.py install for mozsystemmonitor 23:18:49 INFO - Successfully installed mozsystemmonitor 23:18:49 INFO - Cleaning up... 23:18:49 INFO - Return code: 0 23:18:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:18:49 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')]} 23:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:49 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')]} 23:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:49 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:49 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 23:18:49 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 23:18:49 INFO - Using env: {'DISPLAY': ':0', 23:18:49 INFO - 'HOME': '/home/cltbld', 23:18:49 INFO - 'LANG': 'en_US.UTF-8', 23:18:49 INFO - 'LANGUAGE': 'en_US:en', 23:18:49 INFO - 'LOGNAME': 'cltbld', 23:18:49 INFO - 'MAIL': '/var/mail/cltbld', 23:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:49 INFO - 'MOZ_NO_REMOTE': '1', 23:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:49 INFO - 'NO_EM_RESTART': '1', 23:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:49 INFO - 'PWD': '/builds/slave/test', 23:18:49 INFO - 'SHELL': '/bin/bash', 23:18:49 INFO - 'SHLVL': '1', 23:18:49 INFO - 'TERM': 'linux', 23:18:49 INFO - 'TMOUT': '86400', 23:18:49 INFO - 'USER': 'cltbld', 23:18:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:49 INFO - '_': '/tools/buildbot/bin/python'} 23:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:49 INFO - Downloading/unpacking jsonschema==2.5.1 23:18:49 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 23:18:49 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 23:18:49 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 23:18:49 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 23:18:49 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 23:18:49 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 23:18:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:18:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:18:51 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 23:18:51 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 23:18:51 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 23:18:51 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 23:18:51 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 23:18:51 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 23:18:51 INFO - Downloading functools32-3.2.3-2.tar.gz 23:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:18:51 INFO - warning: no files found matching '*.txt' 23:18:51 INFO - no previously-included directories found matching 'build' 23:18:51 INFO - no previously-included directories found matching 'dist' 23:18:51 INFO - no previously-included directories found matching '.git*' 23:18:51 INFO - Installing collected packages: jsonschema, functools32 23:18:51 INFO - Running setup.py install for functools32 23:18:51 INFO - warning: no files found matching '*.txt' 23:18:51 INFO - no previously-included directories found matching 'build' 23:18:51 INFO - no previously-included directories found matching 'dist' 23:18:51 INFO - no previously-included directories found matching '.git*' 23:18:51 INFO - Successfully installed jsonschema functools32 23:18:51 INFO - Cleaning up... 23:18:51 INFO - Return code: 0 23:18:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:51 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:51 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 23:18:51 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 23:18:51 INFO - Using env: {'DISPLAY': ':0', 23:18:51 INFO - 'HOME': '/home/cltbld', 23:18:51 INFO - 'LANG': 'en_US.UTF-8', 23:18:51 INFO - 'LANGUAGE': 'en_US:en', 23:18:51 INFO - 'LOGNAME': 'cltbld', 23:18:51 INFO - 'MAIL': '/var/mail/cltbld', 23:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:51 INFO - 'MOZ_NO_REMOTE': '1', 23:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:51 INFO - 'NO_EM_RESTART': '1', 23:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:51 INFO - 'PWD': '/builds/slave/test', 23:18:51 INFO - 'SHELL': '/bin/bash', 23:18:51 INFO - 'SHLVL': '1', 23:18:51 INFO - 'TERM': 'linux', 23:18:51 INFO - 'TMOUT': '86400', 23:18:51 INFO - 'USER': 'cltbld', 23:18:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:51 INFO - '_': '/tools/buildbot/bin/python'} 23:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:18:52 INFO - Cleaning up... 23:18:52 INFO - Return code: 0 23:18:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:18:52 INFO - Using env: {'DISPLAY': ':0', 23:18:52 INFO - 'HOME': '/home/cltbld', 23:18:52 INFO - 'LANG': 'en_US.UTF-8', 23:18:52 INFO - 'LANGUAGE': 'en_US:en', 23:18:52 INFO - 'LOGNAME': 'cltbld', 23:18:52 INFO - 'MAIL': '/var/mail/cltbld', 23:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:52 INFO - 'MOZ_NO_REMOTE': '1', 23:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:52 INFO - 'NO_EM_RESTART': '1', 23:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:52 INFO - 'PWD': '/builds/slave/test', 23:18:52 INFO - 'SHELL': '/bin/bash', 23:18:52 INFO - 'SHLVL': '1', 23:18:52 INFO - 'TERM': 'linux', 23:18:52 INFO - 'TMOUT': '86400', 23:18:52 INFO - 'USER': 'cltbld', 23:18:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:52 INFO - '_': '/tools/buildbot/bin/python'} 23:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:18:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:18:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 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 23:18:54 INFO - Downloading docopt-0.6.1.tar.gz 23:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:18:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:18:55 INFO - Running setup.py install for blobuploader 23:18:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:18:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:18:55 INFO - Running setup.py install for requests 23:18:55 INFO - Running setup.py install for docopt 23:18:55 INFO - Successfully installed blobuploader requests docopt 23:18:55 INFO - Cleaning up... 23:18:55 INFO - Return code: 0 23:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:55 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:55 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 23:18:55 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 23:18:55 INFO - Using env: {'DISPLAY': ':0', 23:18:55 INFO - 'HOME': '/home/cltbld', 23:18:55 INFO - 'LANG': 'en_US.UTF-8', 23:18:55 INFO - 'LANGUAGE': 'en_US:en', 23:18:55 INFO - 'LOGNAME': 'cltbld', 23:18:55 INFO - 'MAIL': '/var/mail/cltbld', 23:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:55 INFO - 'MOZ_NO_REMOTE': '1', 23:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:55 INFO - 'NO_EM_RESTART': '1', 23:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:55 INFO - 'PWD': '/builds/slave/test', 23:18:55 INFO - 'SHELL': '/bin/bash', 23:18:55 INFO - 'SHLVL': '1', 23:18:55 INFO - 'TERM': 'linux', 23:18:55 INFO - 'TMOUT': '86400', 23:18:55 INFO - 'USER': 'cltbld', 23:18:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:55 INFO - '_': '/tools/buildbot/bin/python'} 23:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:55 INFO - Running setup.py (path:/tmp/pip-QV2E3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:55 INFO - Running setup.py (path:/tmp/pip-QqU9S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:55 INFO - Running setup.py (path:/tmp/pip-wYSUST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:56 INFO - Running setup.py (path:/tmp/pip-hGkKza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:56 INFO - Running setup.py (path:/tmp/pip-IQrGlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:56 INFO - Running setup.py (path:/tmp/pip-JqscZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:56 INFO - Running setup.py (path:/tmp/pip-U0g1JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:56 INFO - Running setup.py (path:/tmp/pip-2OHjOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:56 INFO - Running setup.py (path:/tmp/pip-UEkTkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:56 INFO - Running setup.py (path:/tmp/pip-7lV06W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:56 INFO - Running setup.py (path:/tmp/pip-69SRdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:56 INFO - Running setup.py (path:/tmp/pip-ouDPY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:18:56 INFO - Running setup.py (path:/tmp/pip-jCeR2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:18:56 INFO - Running setup.py (path:/tmp/pip-2wxEPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:56 INFO - Running setup.py (path:/tmp/pip-zyGjv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:18:56 INFO - Running setup.py (path:/tmp/pip-A68xOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:18:57 INFO - Running setup.py (path:/tmp/pip-n4D5pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:18:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:18:57 INFO - Running setup.py install for manifestparser 23:18:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Running setup.py install for mozcrash 23:18:57 INFO - Running setup.py install for mozdebug 23:18:57 INFO - Running setup.py install for mozdevice 23:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Running setup.py install for mozfile 23:18:57 INFO - Running setup.py install for mozhttpd 23:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Running setup.py install for mozinfo 23:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Running setup.py install for mozInstall 23:18:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:18:57 INFO - Running setup.py install for mozleak 23:18:57 INFO - Running setup.py install for mozlog 23:18:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Running setup.py install for moznetwork 23:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Running setup.py install for mozprocess 23:18:58 INFO - Running setup.py install for mozprofile 23:18:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Running setup.py install for mozrunner 23:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Running setup.py install for mozscreenshot 23:18:58 INFO - Running setup.py install for moztest 23:18:58 INFO - Running setup.py install for mozversion 23:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:18:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:18:58 INFO - Cleaning up... 23:18:58 INFO - Return code: 0 23:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:58 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:18:58 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 23:18:58 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 23:18:58 INFO - Using env: {'DISPLAY': ':0', 23:18:58 INFO - 'HOME': '/home/cltbld', 23:18:58 INFO - 'LANG': 'en_US.UTF-8', 23:18:58 INFO - 'LANGUAGE': 'en_US:en', 23:18:58 INFO - 'LOGNAME': 'cltbld', 23:18:58 INFO - 'MAIL': '/var/mail/cltbld', 23:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:58 INFO - 'MOZ_NO_REMOTE': '1', 23:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:58 INFO - 'NO_EM_RESTART': '1', 23:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:58 INFO - 'PWD': '/builds/slave/test', 23:18:58 INFO - 'SHELL': '/bin/bash', 23:18:58 INFO - 'SHLVL': '1', 23:18:58 INFO - 'TERM': 'linux', 23:18:58 INFO - 'TMOUT': '86400', 23:18:58 INFO - 'USER': 'cltbld', 23:18:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:58 INFO - '_': '/tools/buildbot/bin/python'} 23:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:59 INFO - Running setup.py (path:/tmp/pip-26WzNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:59 INFO - Running setup.py (path:/tmp/pip-u2gYOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:59 INFO - Running setup.py (path:/tmp/pip-nai4CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:59 INFO - Running setup.py (path:/tmp/pip-3E0IG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:59 INFO - Running setup.py (path:/tmp/pip-ekzWYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:59 INFO - Running setup.py (path:/tmp/pip-AGKSot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:59 INFO - Running setup.py (path:/tmp/pip-p7NjsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:59 INFO - Running setup.py (path:/tmp/pip-YkShlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:59 INFO - Running setup.py (path:/tmp/pip-jncqer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:59 INFO - Running setup.py (path:/tmp/pip-vG49uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:59 INFO - Running setup.py (path:/tmp/pip-Ikjr15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:59 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)) 23:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:59 INFO - Running setup.py (path:/tmp/pip-CYeMXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:19:00 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)) 23:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:19:00 INFO - Running setup.py (path:/tmp/pip-7_1GvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:19:00 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)) 23:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:19:00 INFO - Running setup.py (path:/tmp/pip-tEiZ_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:19:00 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)) 23:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:00 INFO - Running setup.py (path:/tmp/pip-hl49dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:00 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)) 23:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:19:00 INFO - Running setup.py (path:/tmp/pip-yoZjDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:19:00 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)) 23:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:19:00 INFO - Running setup.py (path:/tmp/pip-hoMTUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:19:00 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)) 23:19:00 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)) 23:19:00 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)) 23:19:00 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)) 23:19:00 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)) 23:19:00 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)) 23:19:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:19: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 23:19: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 23:19: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 23:19: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 23:19: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 23:19: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 23:19:02 INFO - Downloading blessings-1.6.tar.gz 23:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:19:02 INFO - Installing collected packages: blessings 23:19:02 INFO - Running setup.py install for blessings 23:19:02 INFO - Successfully installed blessings 23:19:02 INFO - Cleaning up... 23:19:02 INFO - Return code: 0 23:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:02 INFO - Reading from file tmpfile_stdout 23:19:02 INFO - Current package versions: 23:19:02 INFO - argparse == 1.2.1 23:19:02 INFO - blessings == 1.6 23:19:02 INFO - blobuploader == 1.2.4 23:19:02 INFO - docopt == 0.6.1 23:19:02 INFO - functools32 == 3.2.3-2 23:19:02 INFO - jsonschema == 2.5.1 23:19:02 INFO - manifestparser == 1.1 23:19:02 INFO - mozInstall == 1.12 23:19:02 INFO - mozcrash == 0.17 23:19:02 INFO - mozdebug == 0.1 23:19:02 INFO - mozdevice == 0.48 23:19:02 INFO - mozfile == 1.2 23:19:02 INFO - mozhttpd == 0.7 23:19:02 INFO - mozinfo == 0.9 23:19:02 INFO - mozleak == 0.1 23:19:02 INFO - mozlog == 3.3 23:19:02 INFO - moznetwork == 0.27 23:19:02 INFO - mozprocess == 0.23 23:19:02 INFO - mozprofile == 0.28 23:19:02 INFO - mozrunner == 6.12 23:19:02 INFO - mozscreenshot == 0.1 23:19:02 INFO - mozsystemmonitor == 0.3 23:19:02 INFO - moztest == 0.7 23:19:02 INFO - mozversion == 1.4 23:19:02 INFO - psutil == 3.1.1 23:19:02 INFO - requests == 1.2.3 23:19:02 INFO - wsgiref == 0.1.2 23:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:02 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')]} 23:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:02 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')]} 23:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:02 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:19:02 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 23:19:02 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 23:19:02 INFO - Using env: {'DISPLAY': ':0', 23:19:02 INFO - 'HOME': '/home/cltbld', 23:19:02 INFO - 'LANG': 'en_US.UTF-8', 23:19:02 INFO - 'LANGUAGE': 'en_US:en', 23:19:02 INFO - 'LOGNAME': 'cltbld', 23:19:02 INFO - 'MAIL': '/var/mail/cltbld', 23:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:02 INFO - 'MOZ_NO_REMOTE': '1', 23:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:02 INFO - 'NO_EM_RESTART': '1', 23:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:02 INFO - 'PWD': '/builds/slave/test', 23:19:02 INFO - 'SHELL': '/bin/bash', 23:19:02 INFO - 'SHLVL': '1', 23:19:02 INFO - 'TERM': 'linux', 23:19:02 INFO - 'TMOUT': '86400', 23:19:02 INFO - 'USER': 'cltbld', 23:19:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:02 INFO - '_': '/tools/buildbot/bin/python'} 23:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 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)) 23:19:02 INFO - Cleaning up... 23:19:02 INFO - Return code: 0 23:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:19:02 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')]} 23:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:02 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')]} 23:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:02 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 0x7fea742fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1270850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, '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': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', '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 23:19:02 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 23:19:02 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 23:19:02 INFO - Using env: {'DISPLAY': ':0', 23:19:02 INFO - 'HOME': '/home/cltbld', 23:19:02 INFO - 'LANG': 'en_US.UTF-8', 23:19:02 INFO - 'LANGUAGE': 'en_US:en', 23:19:02 INFO - 'LOGNAME': 'cltbld', 23:19:02 INFO - 'MAIL': '/var/mail/cltbld', 23:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:02 INFO - 'MOZ_NO_REMOTE': '1', 23:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:02 INFO - 'NO_EM_RESTART': '1', 23:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:02 INFO - 'PWD': '/builds/slave/test', 23:19:02 INFO - 'SHELL': '/bin/bash', 23:19:02 INFO - 'SHLVL': '1', 23:19:02 INFO - 'TERM': 'linux', 23:19:02 INFO - 'TMOUT': '86400', 23:19:02 INFO - 'USER': 'cltbld', 23:19:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:02 INFO - '_': '/tools/buildbot/bin/python'} 23:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:19:03 INFO - Cleaning up... 23:19:03 INFO - Return code: 0 23:19:03 INFO - Running post-action listener: _resource_record_post_action 23:19:03 INFO - Running post-action listener: _start_resource_monitoring 23:19:03 INFO - Starting resource monitoring. 23:19:03 INFO - [mozharness: 2016-08-26 06:19:03.216971Z] Finished create-virtualenv step (success) 23:19:03 INFO - [mozharness: 2016-08-26 06:19:03.217532Z] Running install step. 23:19:03 INFO - Running pre-action listener: _resource_record_pre_action 23:19:03 INFO - Running main action method: install 23:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:03 INFO - Reading from file tmpfile_stdout 23:19:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:19:03 INFO - Reading from file tmpfile_stdout 23:19:03 INFO - Output received: 23:19:03 INFO - Usage: mozinstall [options] installer 23:19:03 INFO - Options: 23:19:03 INFO - -h, --help show this help message and exit 23:19:03 INFO - -d DEST, --destination=DEST 23:19:03 INFO - Directory to install application into. [default: 23:19:03 INFO - "/builds/slave/test"] 23:19:03 INFO - --app=APP Application being installed. [default: firefox] 23:19:03 INFO - mkdir: /builds/slave/test/build/application 23:19:03 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'] 23:19:03 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 23:19:21 INFO - Reading from file tmpfile_stdout 23:19:21 INFO - Output received: 23:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 23:19:21 INFO - Running post-action listener: _resource_record_post_action 23:19:21 INFO - [mozharness: 2016-08-26 06:19:21.213694Z] Finished install step (success) 23:19:21 INFO - [mozharness: 2016-08-26 06:19:21.213943Z] Running run-tests step. 23:19:21 INFO - Running pre-action listener: _resource_record_pre_action 23:19:21 INFO - Running main action method: run_tests 23:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:19:21 INFO - Python 2.7.3 23:19:21 INFO - Return code: 0 23:19:21 INFO - grabbing minidump binary from tooltool 23:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:21 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 0x126b370>, '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 0x126e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:19:21 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 23:19:21 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 23:19:21 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 23:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:19:21 INFO - Return code: 0 23:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:19:21 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/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:19:21 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/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 23:19:21 INFO - Using env: {'DISPLAY': ':0', 23:19:21 INFO - 'HOME': '/home/cltbld', 23:19:21 INFO - 'LANG': 'en_US.UTF-8', 23:19:21 INFO - 'LANGUAGE': 'en_US:en', 23:19:21 INFO - 'LOGNAME': 'cltbld', 23:19:21 INFO - 'MAIL': '/var/mail/cltbld', 23:19:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:19:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:21 INFO - 'MOZ_NO_REMOTE': '1', 23:19:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:21 INFO - 'NO_EM_RESTART': '1', 23:19:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:21 INFO - 'PWD': '/builds/slave/test', 23:19:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:19:21 INFO - 'SHELL': '/bin/bash', 23:19:21 INFO - 'SHLVL': '1', 23:19:21 INFO - 'TERM': 'linux', 23:19:21 INFO - 'TMOUT': '86400', 23:19:21 INFO - 'USER': 'cltbld', 23:19:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335', 23:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:21 INFO - '_': '/tools/buildbot/bin/python'} 23:19:21 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/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:19:21 INFO - mozversion application_buildid: 20160825203011 23:19:21 INFO - mozversion application_changeset: b7e8b15d90da87ca0491b9515ca8640f97ef132e 23:19:21 INFO - mozversion application_display_name: Nightly 23:19:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:19:21 INFO - mozversion application_name: Firefox 23:19:21 INFO - mozversion application_remotingname: firefox 23:19:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:19:21 INFO - mozversion application_vendor: Mozilla 23:19:21 INFO - mozversion application_version: 51.0a1 23:19:21 INFO - mozversion platform_buildid: 20160825203011 23:19:21 INFO - mozversion platform_changeset: b7e8b15d90da87ca0491b9515ca8640f97ef132e 23:19:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:19:21 INFO - mozversion platform_version: 51.0a1 23:19:21 INFO - using testdate: 1472192361 23:19:21 INFO - actual date: 1472192361 23:19:21 INFO - starting webserver on 'localhost:44117' 23:19:21 INFO - SUITE-START | Running 2 tests 23:19:21 INFO - TEST-START | dromaeo_css 23:19:21 INFO - operating with platform_type : linux_ 23:19:21 INFO - Initialising browser for dromaeo_css test... 23:19:21 INFO - TEST-INFO | started process 32706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgjFSVo/profile http://localhost:44117/getInfo.html) 23:19:25 INFO - PROCESS | 32706 | __metrics Screen width/height:1600/1200 23:19:25 INFO - PROCESS | 32706 | colorDepth:24 23:19:25 INFO - PROCESS | 32706 | Browser inner width/height: 1024/697 23:19:25 INFO - PROCESS | 32706 | __metrics 23:19:26 INFO - PROCESS | 32706 | 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" 23:19:26 INFO - PROCESS | 32706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:19:26 INFO - PROCESS | 32706 | console.error: PushService: 23:19:26 INFO - PROCESS | 32706 | stateChangeProcessEnqueue: Error transitioning state 23:19:26 INFO - PROCESS | 32706 | UnknownError 23:19:27 INFO - TEST-INFO | 32706: exit 0 23:19:27 INFO - Browser initialized. 23:19:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:19:27 INFO - TEST-INFO | started process 318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgjFSVo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:39 INFO - PROCESS | 318 | RSS: Main: 179138560 23:19:39 INFO - PROCESS | 318 | 23:20:31 INFO - PROCESS | 318 | 1472192431121 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] 23:22:40 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44117/tests/dromaeo/cssquery-ext.html) 23:22:41 INFO - PROCESS | 318 | RSS: Main: 296296448 23:22:41 INFO - PROCESS | 318 | 23:25:43 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-ext.html (next: http://localhost:44117/tests/dromaeo/cssquery-jquery.html) 23:25:44 INFO - PROCESS | 318 | RSS: Main: 268722176 23:25:44 INFO - PROCESS | 318 | 23:28:46 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44117/tests/dromaeo/cssquery-mootools.html) 23:28:47 INFO - PROCESS | 318 | RSS: Main: 244543488 23:28:47 INFO - PROCESS | 318 | 23:31:49 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44117/tests/dromaeo/cssquery-prototype.html) 23:31:49 INFO - PROCESS | 318 | RSS: Main: 216723456 23:31:49 INFO - PROCESS | 318 | 23:34:52 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44117/tests/dromaeo/cssquery-yui.html) 23:34:53 INFO - PROCESS | 318 | RSS: Main: 218148864 23:34:53 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:44117/tests/dromaeo/cssquery-yui.html (next: http://localhost:44117/tests/dromaeo/cssquery-dojo.html) 23:37:56 INFO - PROCESS | 318 | RSS: Main: 306049024 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | __start_tp_report 23:37:56 INFO - PROCESS | 318 | _x_x_mozilla_page_load 23:37:56 INFO - PROCESS | 318 | _x_x_mozilla_page_load_details 23:37:56 INFO - PROCESS | 318 | |i|pagename|runs| 23:37:56 INFO - PROCESS | 318 | |0;dojo.html;3032.4844776388004;3047.5733397324366;3050.7254347108765;3077.923051923703;3107.518334658129;5141.974290128554;5210.400803907552;5255.973720131399;5339.89320213596;5388.91916621251;5286.392064912527;5289.814856480024;5340.198970154469;5361.115415956372;5393.1370980643105;4782.545658162487;4806.182948898687;4821.108095002418;4831.323614693928;5009.899802003976;4901.754912254391;4943.036107958949;4954.182559877616;4958.95861869008;4978.452370239271;4799.760011999386;4847.321375007502;4859.052484765472;4905.730184839815;4954;4805.3753012108555;4826.227803551415;4829.1790395632825;4862.416510018785;4862.82980095695;4806.855794326176;4828.058528586892;4833.951660483385;4842.12841688496;4900.044491324194;5192.324997750268;5385.5960802939935;5389.703566303851;5390.8382748517215;5395.298611180521;5618.803341883015;5670.886582268332;5681.602287839853;5694.288213973254;5699.886002279973;5692.686902220376;5725.513331366838;5730.19777231188;5731.025725626653;5752.424757524256;5247.003069416799;5288.709120998382;5347.41178470368;5354.089804733166;5356.11624082026;5796.449337312949;5822.621529600562;5823.388544202882;5893.5579831512805;5937.495312898365;5601.271834661549;5638.2670252866865;5639.041362968305;5642.85892852682;5644.32268127819;5506.394296627368;5571.192177134293;5630.5495560355075;5641.605087643826;5644.604877658525;5665.5184309333345;5686.459786320293;5702.144678298288;5737.254156959569;5767.913481297784;5671.773129074873;5706.600537962303;5709.685967271756;5709.771609135588;5712.6286791358425;4197.685173611992;4319.8488052918;4327.870163895088;4328.415663885398;4383.452068491439;3945.112349721347;3947.82234799429;3986.80065996699;4012.558618551957;4040.8383664653675;5457.672539647554;5460.6996615186545;5462.508374246337;5466.890662186814;5467.781288748405;5613.186088017214;5626.127950167731;5811.157382179645;5827;5827.88344233113;5292.364916210079;5355;5363.19552067193;5400.405955344909;5419.864503387368;4884.218525035977;4894.339264199359;4901.534354236342;4924.3105965164905;4950.455449900508;5708.372079071216;5821.970890145607;5834.649921004753;5846.795362162304;5882.441168089024;5788.363280039108;5830.854228644318;5833.562482813891;5880.617759845596;5901.734421951109;5931.851703707442;5936.7922122725495;5948.10778383246;5951.137085122719;5988.5508586855285;5492.972535137299;5617.241672374177;5692.658440493584;5694.117411801178;5699.857503562278;5705.828825135252;5749.195112684311;5760.711964401679;5849.64902105875;5851.1515830205235;5613.494785469327;5614.5789065821045;5616.915746263891;5623;5623.578231632562;5485.561155107662;5524.613277070727;5585.860353491195;5587.69267690281;5591.916121258103;5565.693886836263;5598;5605.383407825055;5655.915161272502;5658.151277308437;5588.329400471969;5610.382857885547;5614.101743720985;5624.746886390204;5631.8592035199445;5339.172428273624;5345.705986170798;5484.945150548443;5492.368377636463;5494.560435165097 23:37:56 INFO - PROCESS | 318 | |1;ext.html;555.6059398284494;585.1427658480326;600.762698734;607.7083000159926;622.3993845938668;41756.58243417565;43466;43710.344344834855;43830.342544861815;47028.76485617576;44797.328040079425;45237.547624523744;45291.54708452914;45322;45379;8234.135415781346;8982.730518084436;9127.452352858816;9134.314926380548;10621.309614875046;10358.792824143513;10740;10741.892581074206;10786.622468213614;10786.73033174173;10890.128789696806;10930;10936.56253749853;10944.288621239633;10945.83581246282;10836.403997780119;10854.72863178423;10866.891331086747;10867.45662716861;10881.12950963921;10776.40729759863;10809.83785243222;10841.457927103613;10855.077318427942;10856.511456984455;42281.36577951333;42610.78694606538;42654.78672606617;42674.359884601756;42687.7865610673;3488.4244099723514;3572.214112895185;3964.8414063437426;4139.937900931488;4214.178235244129;32502.512462313083;33013;33066.17334566631;33126.503102453484;33134.17164570881;4403.801828917706;4413.29387298034;4499.100179963988;4517.254652982254;4550.943622191848;257136;259108;259163;260822;261420;48533;48753.51246487561;48782.75608621934;48805;48855.511444885095;59603.40396596065;59810.70094649499;59947.405785363575;60018.39981600215;60021.69989150026;15527.146006969726;15575.766363504557;15715.921420392824;15724.764128538081;15729.842701573067;9956.352837065568;12564.685882852818;13043.804342934864;13098.934505327412;13342.533011344556;15633.530994070195;15693.215339232993;15723;15742.212889355487;15840.28718707638;5843.152742852262;5972.134040564094;5981.730822113015;6021.217241758631;6022.675011497464;794.9006374203225;1016.7559785651538;1031.8452232165234;1108.6286094158547;1120.6974116988367;31462.528062079087;32145.357092858012;32156.678433215835;32334;32861.67138328634;1095.5453486803046;1102.6361300770727;1110.9333439993627;1170.5142365918218;1177.252444697623;15412.691746165014;16228.350865965465;16254.674906501803;16264.349426022827;16493;473897;477355;478252;478947;479198;55912;55946.72026639922;55995;56099.71950140223;56106.438935610124;1239.070696977267;1349.9932500337632;1350;1367.282176857158;1372.1629805818243;32232.83883580567;33762.3247535043;34324.31351372909;34434.31131377409;34523.30953380968;48903.510964889894;48982.5101748978;49190.75404623097;49315;49474.50525494699;370696;372297;372522;372960;373485;28801.71198288074;29473.410531789672;29597.556036659036;29653.703462965095;29787.404251915275;48695.51304487052;48928.75535622299;49047;49524.50475495343;49630.25554616756;40871.79564102161;41112.38331424971;41289.94846005;41888;43556.34665479957;39605.80197098996;40276.3958540628;40336.05907942577;40606;40869.79565102155;40244.597554025255;41817.79091104525;42380.36429453622;42495;44965.77517112524;32675.34649307048;36673.266534668626;36751.54714415753;39735;40356.59643403528;28456.57315140316;28620.57069143923;28688.569671455363;28742.425151496434;28852.567211491423 23:37:56 INFO - PROCESS | 318 | |2;jquery.html;371.3983346977896;385.61245947822437;397.92041591681664;400.72149855850176;404.5509484472235;16683.165841707912;19409.02954852257;19464.610707785872;19606.411807645774;20512.8974355128;19902;20162.798372016274;20304.18783248668;20365.694514582294;20503.794962050375;5217.5565076968505;5764.077747560391;5927.347991720907;5967.403259674042;5991.550633702468;5869.618474799146;5957.344692083867;5964.314103878066;5965.46310832025;5971.581989260753;5634.436556344353;5872.7063646817705;5875.559333050017;5908.911366329508;6000.489958353545;5706.828795136111;5844.152597873306;5890.911636325459;5900.232969713931;5901.793437229698;5637.7181140942785;5694;5696.088625819891;5699.8005069822775;5701.25883635129;14238.359273832599;14385.907029988499;23275.301740947798;23951.16170934009;24116.879415602983;2227.6881236626887;2582.1607977407416;2723.400851812598;2759.1584566707147;2937.0748214312425;10623.734406639818;10751.892481075167;11748.882511174865;12453.501859925593;15531.767023494656;1864.3288416170167;1878.8402985746227;1882.6526296935779;1950.5903760210372;1987.8707883987495;81377;87694.12305876924;87814.56092719559;88324;89677.55161224153;11133.165012624086;11293.71765705864;11472.426378681033;11698.2981021139;11806.586769463027;16219.594510137342;16247.943883647526;16266.75599866003;16282.918585406996;16287.185640718153;8091.55496447701;8177.386695997705;8397.538135402488;8419.07390187079;8470.534120623302;7448.625957924495;7452.515586486969;7647.273509016634;7839.294463498312;8284.337253019745;4750.833720819824;4816.373871396696;4882.902341953141;4953.405591329064;4955.306257124005;1929.9614007719767;1972.8056632529103;1984.9206031758567;1993.451800754775;2008.2368699893948;894.2667013049368;931.888173419194;951.2770294576034;966.8936416994125;1037.6523864505325;18563.35028274004;19985.30051448192;20072.49818754543;20113.39659810208;20590.485237869172;940.9247260219166;961.6538046303325;977.2328721953232;988.5749127875083;992.5186284651938;10555.208359373079;10863.130949524018;11124;11138.777224455465;11178.608748693756;480921;482636;488409;494328;504946;83003;90308;100347.49826250822;101027.49486252521;102111.48944255231;983.3215081593678;1020.4897551224387;1045.7281106912258;1050.7635781949;1057.94710264488;17841.375551855625;17883.37408190707;18734.718979215595;18775.781703739827;18847.340343087926;33918.66081339155;42809.357859631506;42887.35668964906;44218.557814421445;45343.09313813639;59212;59510.40489595049;61378.693106534185;63011.684941575;63736.04395933972;8630.78423039404;8666.480011199348;8764.462562196379;8788.736337909873;8897.644094236159;12113.878861211275;12558.434870431036;12693.936530317658;13633.795493067413;13684.45262189541;11660;11854.822177667515;11980.520779168735;12096.818547721967;12172.695682608006;11364.602238921598;11749.118816088998;11809.704757381134;11836.704082397664;12051.035917126785;12017.098717596391;12043.277403355827;12065.09511786637;12374.257544547356;12468.251904885736;7522.962385188039;7540.17058123617;7839.725609603636;8583.399162058597;8642.265407440438;8544.957275213585;11654;11826.940865295619;11846.170768046153;11992.280463172237 23:37:56 INFO - PROCESS | 318 | |3;mootools.html;1342.1276170489175;1439.8128243328365;1478.6229511474576;1574.23649529978;1760.7446920196571;8006.199380061991;8371.414001019932;8438.156184381567;8618.095100014501;8629.525376104311;8415.28470080044;8501;8510.70212542561;8519.701810436636;8522.360822938273;2354.635031570105;2377.215518878766;2380.7619238076227;2381.1784934197676;2385.224801939368;2285.074544809355;2362.0669835415;2363.0311572255378;2369.0642196332524;2369.1707902234252;2336.707911511061;2358.5047140100514;2360.9645855312183;2374.157174203159;2375.228050883461;2272.329662749493;2298.8275879309117;2305.3199306204624;2312.028947841902;2324.8721320327377;2268.3421807675754;2274.715660542432;2275.260540324401;2278.874661893595;2280.5780930527903;8348.039975402846;8490.74527764162;8581.184787445183;8590.957045214735;8596.570171491401;5032.345795046621;5228.843134705965;5240.7379631018675;5268.315119034501;5274.55166310864;3194.4409728297687;3344.4782623906062;3352.8491217895253;3403.183236023361;3422.6235114137426;1198.9400529973466;1217.379136640311;1223.4188760338857;1231.9836135188505;1242.5588915934804;11718.296902185812;11740.706482337924;11800.763984720343;11802.232854864493;11821.408929553489;4158.750474971512;4348.478182618106;4460.375547423363;4531.750753708512;4560.156371071363;9188.402753821114;9190.356675032817;9191.402558833654;9195.862062069074;9258.90741092594;5073.8731531712;5084.567811736044;5100.158473851847;5125.718085505258;5128;4177.373393990925;4617.0996655651825;4668.5098064702715;4712.552307530779;4782.852115492256;3531.134871956387;3572.160542272564;3655.3054919565197;3660.8352624131976;3698.8335524901445;1109.983350249747;1117.3240139790314;1123.8763735989035;1128.4865386249237;1132.8470656461272;747.7345542332503;847.8304339132075;964.8118616869783;973.8198433289864;1007.6120693532896;5464.617351908367;5526.419725928719;5575.609707320448;5649.915251271234;6111.327753947062;456.3702091114241;466.58774137708133;467.847949416441;489.65479337067285;650.7343217442029;3882.611738826095;3963.4451176835264;3994.78028708418;4008.4187792769885;4070.357030457724;9607.903920960702;10293.897061029444;10448.947755261175;10460.843087353696;10475.738106547396;10129.999999999853;10316.948415257875;10361.792764144826;10377.066064054272;10377.377357358582;7782.105057918412;7917.168697286817;7940.6029698515995;7944.682212711542;7945;5624.74688639004;5642.322921249476;5644.943550564606;5675.120356344773;5829.883402332014;9546;9614.086661767122;9645.565949532429;9687.709368718668;9732.46471444049;9609.51952402391;9660.565274562801;9694.85457718149;9884.85172722424;9898.455584942898;7171.103612048494;7223.891641625485;7235.480549084751;7237;7237.3486386225495;8202.630881610461;8241.25828675398;8243.25810677042;8247.835043298981;8273.875891861506;7399.593022383605;7539.0576177977755;7564.810879728051;7618.657160427683;7717.305442509976;7222.277772222736;7339.633018349168;7365.8158546036775;7576.507527010726;7603.163651998165;6439.839004024937;6554.934450655433;6571.441427478718;6574.539782215199;6577.638229897401;5093.439721630692;5225.346831646044;5240.109181439088;5320.5477534408465;5409.918851217156;5040.117979353672;5333.893322133613;5369.087255166709;5378.596605254544;5395.622306438511 23:37:56 INFO - PROCESS | 318 | |4;prototype.html;318.8437665543884;324.10708498087763;329.54193670797594;332.17785979700227;333.25184959765346;5301.257823904652;5360.624756267053;5362.168863826103;5367.677939323638;5370.133503877207;5213.244079608455;5231.189165679316;5238.240455134013;5283.2867562879;5299.33758280215;3881.6312450317314;4163.39630753542;4164.7709375984305;4167.708260421772;4175.227582897159;4116.382542618616;4125.731827431207;4139.275626765319;4146.751194928299;4154.231467178566;4066.909149046731;4076.6331030207275;4087.795610219492;4088.7342322748927;4125.443065186191;3903.609639036102;3913.1391093959282;4061.390791381287;4097.938530922039;4113.91772164555;3517.6834084932225;3529.38235808735;3539.486774417721;3543.273628906068;3570.5715314162208;5062.443131255559;5068.163752980754;5074.314967479417;5094.61790365724;5149.348085735812;4291.50647675515;4371.934420983688;4508.278675411952;4641;4664.626829853603;5417.943501017303;5419.617997410674;5420.539254163361;5440.259117082535;5468.371137319219;3884.902877428087;3905.785181814999;3921.117748506592;3942.6057394260633;3951.150502641946;5452.754626041838;5692.48767610917;5712.771489140471;5758.827235182951;5804.9419505805245;4010.318245898204;4018.8593399230886;4022.879313620596;4024.3561030235023;4031.3952907064177;4073.716779214538;4081.0616356223472;4082.6937979651643;4091.774952377648;4093.488313960755;4523.479799823062;4691.62467002639;4700.600448961808;4706.247000479907;4720.395065677618;5490.533304669068;5490.615656903979;5519.199716041232;5523.177351474004;5592.832215033555;1377.827771528559;1390.3107724115248;1400.3838311143065;1408.1269612840106;1408.5211028250444;846.3187134356901;894.552723638181;902.4089221559758;915.2174890468686;915.9038300978301;4613.653975951817;4671.95328046722;4719.339292499053;4733.219018861918;4739.454962679336;4962.082014827269;4976.726280054631;4978.8755281118265;5052.898942021139;5069.400725484947;4750.358701575312;4761.47623761386;4762.118918054596;4797.352357431771;5030.949690503048;2870;2923.97076029237;2972.524396096614;2990.4019196160857;3034.2717747740385;5836.8540786479825;5854.912176317359;5872.442117998783;5905.409459054146;5905.675187864623;5615.719214039282;5806.30324361071;5827.3298570664065;5828.388019257917;5838.241028666246;5826.41735826414;5875.706214689163;5881.500362345901;5886.087656413263;5894.8821023579285;5577.60956733041;5622.550195984393;5650.29371328584;5658.830235092953;5686.242172546395;5382.757775900016;5596.272484576979;5597.888042239214;5620.690862002629;5623.184638227516;5825.94174058271;5830.2129212555765;5833.4749872511675;5835.241418615553;5866.178734977021;3982.820773065161;4035.878923632296;4037.5962403760564;4044.1102957349335;4045.7977101145416;5437.809676661298;5621.718914054362;5629.521490673339;5634.408387119457;5666.716664166693;5431.565474762088;5453.7818487260065;5473.616846820843;5484.972575137099;5495.945040549544;5271.578273738169;5453.890922181614;5496.285482887199;5499.642523235977;5510.256115424367;5452.509274165344;5473.31583552056;5474.562035037267;5496.367917689357;5498.670079795225;5496.422875598005;5499.312585926759;5512.751926163252;5522.641028333145;5560.6107572471155;5200.557952574073;5329.782125477185;5363.490468405495;5452.454754524516;5459.781608735765 23:37:56 INFO - PROCESS | 318 | |5;yui.html;747.5327920049967;757.3032809814973;774.5004472115486;816.261283538398;878.2359347367789;14993.700125997473;15502.22488875556;16634.66730665389;16908.1545922704;16909.7463538047;15439.614009649764;15483.69032619347;15512.069275843458;15522.068675879455;15643.530694079167;666.4202144134609;794.4915254237293;811.1563973467587;814.9592520373988;815.2621877201143;794.3010151067053;831.7795784117213;833.737372727592;840.5671079394117;840.6385254340631;870.7561882672861;872.8559787635032;873.4409977614332;873.7247766953421;873.7640836974045;696.5472442912147;869.9347548933855;871.651339464213;872.4503562755456;872.9301655867515;603.1043899808781;619.102301662591;621.561798931752;627.7394881124374;628.2868943748878;15221.771673424908;15255.923720381437;15261.084334939938;15283.159426231552;15366;13963.371648275852;14272.785908211385;14530.854691453162;14551.322667511458;14633;13327.267000315076;13434.932825335909;13589.456421743118;13779.793303100461;13885.236312002937;4402.889927751799;4457.821687132511;4464.419625448671;4467.5755803198645;4515.277555591122;82214;83197.58401207955;83271.5836420814;83380;85886.57056714738;11241.60654377093;11246.7188320291;11418.714532136763;11504.827427588592;11533.826992595117;21787;21841;21862.453438663844;21862.562748744935;21881.452963676034;8589.957050214709;8767.254783343487;8900.42147260426;9100.453972761656;9106.590203440861;4939.185034469344;4953.950460495421;4997.90004199914;5117.8464646060675;5131.538161565402;3379.425497665403;3472.808995505221;3497.4229252173614;3498.3877821381157;3501.77238479498;616.3097330989231;635.5900444213456;635.8219698484431;648.4067078623101;653.258551544001;698.4063545985871;752.9661165247577;783.6591082878966;788.6332855222349;801.1147681811631;9615.51922403891;9683.32216744821;9712.660056897974;10378.688639340831;10985;704.4681265644406;725.1044959475045;749.4978364495801;752.2627824731684;768.8961990131261;5108.131617625013;5289.709066001406;5297.152455607084;5308.867278318073;5310.628256022042;73586.63206683932;91142.54428727814;99837;105867;106170;77334.61332693414;89556.5522172385;92068.53965730128;92591.0740892596;93816;75565;75700;75741.9999999989;87660;88419;9442.905570944202;9582.233421326417;10140.543675534765;10431.321964072311;10620.575176992834;52626;53264.46735532595;53639.73180134074;54084;54247.405363248385;68439.31560684329;77652.61173694095;78574.607126964;79079.20920790719;80710.36803343981;12115.575954841539;12358.81461778092;12470.314132722788;12652.114351995271;12776.36118194068;15023.924880375529;15119.622009449851;15252.771208432105;15866.127362994685;15942.123183225034;13933.303334833015;14533.78199327032;14692.045017073857;14889.85110148928;15075.698486030436;14136.575902722934;14418.639534011734;14733.484328048895;14912.403503859725;15313;14120.435182592992;15423.537293881202;15449.227538623249;15467.613309667347;15487.690246195238;9670.951645241728;9775.608975640895;9905.405675659484;10036.799264014824;10049.899501004897;9310;9729.318947673595;9742.220622350053;10251.333663311862;10497.842532361869 23:37:56 INFO - PROCESS | 318 | __end_tp_report 23:37:56 INFO - PROCESS | 318 | __start_cc_report 23:37:56 INFO - PROCESS | 318 | _x_x_mozilla_cycle_collect,989 23:37:56 INFO - PROCESS | 318 | __end_cc_report 23:37:56 INFO - PROCESS | 318 | __startTimestamp1472193476400__endTimestamp 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | ------- Summary: start ------- 23:37:56 INFO - PROCESS | 318 | Number of tests: 6 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#0] dojo.html Cycles:165 Average:5310.27 Median:5506.39 stddev:604.36 (11.0%) stddev-sans-first:579.20 23:37:56 INFO - PROCESS | 318 | Values: 3032.5 3047.6 3050.7 3077.9 3107.5 5142.0 5210.4 5256.0 5339.9 5388.9 5286.4 5289.8 5340.2 5361.1 5393.1 4782.5 4806.2 4821.1 4831.3 5009.9 4901.8 4943.0 4954.2 4959.0 4978.5 4799.8 4847.3 4859.1 4905.7 4954.0 4805.4 4826.2 4829.2 4862.4 4862.8 4806.9 4828.1 4834.0 4842.1 4900.0 5192.3 5385.6 5389.7 5390.8 5395.3 5618.8 5670.9 5681.6 5694.3 5699.9 5692.7 5725.5 5730.2 5731.0 5752.4 5247.0 5288.7 5347.4 5354.1 5356.1 5796.4 5822.6 5823.4 5893.6 5937.5 5601.3 5638.3 5639.0 5642.9 5644.3 5506.4 5571.2 5630.5 5641.6 5644.6 5665.5 5686.5 5702.1 5737.3 5767.9 5671.8 5706.6 5709.7 5709.8 5712.6 4197.7 4319.8 4327.9 4328.4 4383.5 3945.1 3947.8 3986.8 4012.6 4040.8 5457.7 5460.7 5462.5 5466.9 5467.8 5613.2 5626.1 5811.2 5827.0 5827.9 5292.4 5355.0 5363.2 5400.4 5419.9 4884.2 4894.3 4901.5 4924.3 4950.5 5708.4 5822.0 5834.6 5846.8 5882.4 5788.4 5830.9 5833.6 5880.6 5901.7 5931.9 5936.8 5948.1 5951.1 5988.6 5493.0 5617.2 5692.7 5694.1 5699.9 5705.8 5749.2 5760.7 5849.6 5851.2 5613.5 5614.6 5616.9 5623.0 5623.6 5485.6 5524.6 5585.9 5587.7 5591.9 5565.7 5598.0 5605.4 5655.9 5658.2 5588.3 5610.4 5614.1 5624.7 5631.9 5339.2 5345.7 5484.9 5492.4 5494.6 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#1] ext.html Cycles:180 Average:54273.83 Median:372409.50 stddev:100392.85 (27.0%) stddev-sans-first:100593.46 23:37:56 INFO - PROCESS | 318 | Values: 555.6 585.1 600.8 607.7 622.4 41756.6 43466.0 43710.3 43830.3 47028.8 44797.3 45237.5 45291.5 45322.0 45379.0 8234.1 8982.7 9127.5 9134.3 10621.3 10358.8 10740.0 10741.9 10786.6 10786.7 10890.1 10930.0 10936.6 10944.3 10945.8 10836.4 10854.7 10866.9 10867.5 10881.1 10776.4 10809.8 10841.5 10855.1 10856.5 42281.4 42610.8 42654.8 42674.4 42687.8 3488.4 3572.2 3964.8 4139.9 4214.2 32502.5 33013.0 33066.2 33126.5 33134.2 4403.8 4413.3 4499.1 4517.3 4550.9 257136.0 259108.0 259163.0 260822.0 261420.0 48533.0 48753.5 48782.8 48805.0 48855.5 59603.4 59810.7 59947.4 60018.4 60021.7 15527.1 15575.8 15715.9 15724.8 15729.8 9956.4 12564.7 13043.8 13098.9 13342.5 15633.5 15693.2 15723.0 15742.2 15840.3 5843.2 5972.1 5981.7 6021.2 6022.7 794.9 1016.8 1031.8 1108.6 1120.7 31462.5 32145.4 32156.7 32334.0 32861.7 1095.5 1102.6 1110.9 1170.5 1177.3 15412.7 16228.4 16254.7 16264.3 16493.0 473897.0 477355.0 478252.0 478947.0 479198.0 55912.0 55946.7 55995.0 56099.7 56106.4 1239.1 1350.0 1350.0 1367.3 1372.2 32232.8 33762.3 34324.3 34434.3 34523.3 48903.5 48982.5 49190.8 49315.0 49474.5 370696.0 372297.0 372522.0 372960.0 373485.0 28801.7 29473.4 29597.6 29653.7 29787.4 48695.5 48928.8 49047.0 49524.5 49630.3 40871.8 41112.4 41289.9 41888.0 43556.3 39605.8 40276.4 40336.1 40606.0 40869.8 40244.6 41817.8 42380.4 42495.0 44965.8 32675.3 36673.3 36751.5 39735.0 40356.6 28456.6 28620.6 28688.6 28742.4 28852.6 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#2] jquery.html Cycles:180 Average:29474.89 Median:2848.12 stddev:81056.48 (2846.0%) stddev-sans-first:81254.41 23:37:56 INFO - PROCESS | 318 | Values: 371.4 385.6 397.9 400.7 404.6 16683.2 19409.0 19464.6 19606.4 20512.9 19902.0 20162.8 20304.2 20365.7 20503.8 5217.6 5764.1 5927.3 5967.4 5991.6 5869.6 5957.3 5964.3 5965.5 5971.6 5634.4 5872.7 5875.6 5908.9 6000.5 5706.8 5844.2 5890.9 5900.2 5901.8 5637.7 5694.0 5696.1 5699.8 5701.3 14238.4 14385.9 23275.3 23951.2 24116.9 2227.7 2582.2 2723.4 2759.2 2937.1 10623.7 10751.9 11748.9 12453.5 15531.8 1864.3 1878.8 1882.7 1950.6 1987.9 81377.0 87694.1 87814.6 88324.0 89677.6 11133.2 11293.7 11472.4 11698.3 11806.6 16219.6 16247.9 16266.8 16282.9 16287.2 8091.6 8177.4 8397.5 8419.1 8470.5 7448.6 7452.5 7647.3 7839.3 8284.3 4750.8 4816.4 4882.9 4953.4 4955.3 1930.0 1972.8 1984.9 1993.5 2008.2 894.3 931.9 951.3 966.9 1037.7 18563.4 19985.3 20072.5 20113.4 20590.5 940.9 961.7 977.2 988.6 992.5 10555.2 10863.1 11124.0 11138.8 11178.6 480921.0 482636.0 488409.0 494328.0 504946.0 83003.0 90308.0 100347.5 101027.5 102111.5 983.3 1020.5 1045.7 1050.8 1057.9 17841.4 17883.4 18734.7 18775.8 18847.3 33918.7 42809.4 42887.4 44218.6 45343.1 59212.0 59510.4 61378.7 63011.7 63736.0 8630.8 8666.5 8764.5 8788.7 8897.6 12113.9 12558.4 12693.9 13633.8 13684.5 11660.0 11854.8 11980.5 12096.8 12172.7 11364.6 11749.1 11809.7 11836.7 12051.0 12017.1 12043.3 12065.1 12374.3 12468.3 7523.0 7540.2 7839.7 8583.4 8642.3 8545.0 11654.0 11826.9 11846.2 11992.3 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#3] mootools.html Cycles:180 Average:5566.57 Median:5126.86 stddev:3121.02 (60.9%) stddev-sans-first:3113.63 23:37:56 INFO - PROCESS | 318 | Values: 1342.1 1439.8 1478.6 1574.2 1760.7 8006.2 8371.4 8438.2 8618.1 8629.5 8415.3 8501.0 8510.7 8519.7 8522.4 2354.6 2377.2 2380.8 2381.2 2385.2 2285.1 2362.1 2363.0 2369.1 2369.2 2336.7 2358.5 2361.0 2374.2 2375.2 2272.3 2298.8 2305.3 2312.0 2324.9 2268.3 2274.7 2275.3 2278.9 2280.6 8348.0 8490.7 8581.2 8591.0 8596.6 5032.3 5228.8 5240.7 5268.3 5274.6 3194.4 3344.5 3352.8 3403.2 3422.6 1198.9 1217.4 1223.4 1232.0 1242.6 11718.3 11740.7 11800.8 11802.2 11821.4 4158.8 4348.5 4460.4 4531.8 4560.2 9188.4 9190.4 9191.4 9195.9 9258.9 5073.9 5084.6 5100.2 5125.7 5128.0 4177.4 4617.1 4668.5 4712.6 4782.9 3531.1 3572.2 3655.3 3660.8 3698.8 1110.0 1117.3 1123.9 1128.5 1132.8 747.7 847.8 964.8 973.8 1007.6 5464.6 5526.4 5575.6 5649.9 6111.3 456.4 466.6 467.8 489.7 650.7 3882.6 3963.4 3994.8 4008.4 4070.4 9607.9 10293.9 10448.9 10460.8 10475.7 10130.0 10316.9 10361.8 10377.1 10377.4 7782.1 7917.2 7940.6 7944.7 7945.0 5624.7 5642.3 5644.9 5675.1 5829.9 9546.0 9614.1 9645.6 9687.7 9732.5 9609.5 9660.6 9694.9 9884.9 9898.5 7171.1 7223.9 7235.5 7237.0 7237.3 8202.6 8241.3 8243.3 8247.8 8273.9 7399.6 7539.1 7564.8 7618.7 7717.3 7222.3 7339.6 7365.8 7576.5 7603.2 6439.8 6554.9 6571.4 6574.5 6577.6 5093.4 5225.3 5240.1 5320.5 5409.9 5040.1 5333.9 5369.1 5378.6 5395.6 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#4] prototype.html Cycles:180 Average:4583.23 Median:5206.90 stddev:1354.36 (26.0%) stddev-sans-first:1319.80 23:37:56 INFO - PROCESS | 318 | Values: 318.8 324.1 329.5 332.2 333.3 5301.3 5360.6 5362.2 5367.7 5370.1 5213.2 5231.2 5238.2 5283.3 5299.3 3881.6 4163.4 4164.8 4167.7 4175.2 4116.4 4125.7 4139.3 4146.8 4154.2 4066.9 4076.6 4087.8 4088.7 4125.4 3903.6 3913.1 4061.4 4097.9 4113.9 3517.7 3529.4 3539.5 3543.3 3570.6 5062.4 5068.2 5074.3 5094.6 5149.3 4291.5 4371.9 4508.3 4641.0 4664.6 5417.9 5419.6 5420.5 5440.3 5468.4 3884.9 3905.8 3921.1 3942.6 3951.2 5452.8 5692.5 5712.8 5758.8 5804.9 4010.3 4018.9 4022.9 4024.4 4031.4 4073.7 4081.1 4082.7 4091.8 4093.5 4523.5 4691.6 4700.6 4706.2 4720.4 5490.5 5490.6 5519.2 5523.2 5592.8 1377.8 1390.3 1400.4 1408.1 1408.5 846.3 894.6 902.4 915.2 915.9 4613.7 4672.0 4719.3 4733.2 4739.5 4962.1 4976.7 4978.9 5052.9 5069.4 4750.4 4761.5 4762.1 4797.4 5030.9 2870.0 2924.0 2972.5 2990.4 3034.3 5836.9 5854.9 5872.4 5905.4 5905.7 5615.7 5806.3 5827.3 5828.4 5838.2 5826.4 5875.7 5881.5 5886.1 5894.9 5577.6 5622.6 5650.3 5658.8 5686.2 5382.8 5596.3 5597.9 5620.7 5623.2 5825.9 5830.2 5833.5 5835.2 5866.2 3982.8 4035.9 4037.6 4044.1 4045.8 5437.8 5621.7 5629.5 5634.4 5666.7 5431.6 5453.8 5473.6 5485.0 5495.9 5271.6 5453.9 5496.3 5499.6 5510.3 5452.5 5473.3 5474.6 5496.4 5498.7 5496.4 5499.3 5512.8 5522.6 5560.6 5200.6 5329.8 5363.5 5452.5 5459.8 23:37:56 INFO - PROCESS | 318 | 23:37:56 INFO - PROCESS | 318 | [#5] yui.html Cycles:180 Average:20378.29 Median:5309.75 stddev:27936.88 (526.1%) stddev-sans-first:27976.36 23:37:56 INFO - PROCESS | 318 | Values: 747.5 757.3 774.5 816.3 878.2 14993.7 15502.2 16634.7 16908.2 16909.7 15439.6 15483.7 15512.1 15522.1 15643.5 666.4 794.5 811.2 815.0 815.3 794.3 831.8 833.7 840.6 840.6 870.8 872.9 873.4 873.7 873.8 696.5 869.9 871.7 872.5 872.9 603.1 619.1 621.6 627.7 628.3 15221.8 15255.9 15261.1 15283.2 15366.0 13963.4 14272.8 14530.9 14551.3 14633.0 13327.3 13434.9 13589.5 13779.8 13885.2 4402.9 4457.8 4464.4 4467.6 4515.3 82214.0 83197.6 83271.6 83380.0 85886.6 11241.6 11246.7 11418.7 11504.8 11533.8 21787.0 21841.0 21862.5 21862.6 21881.5 8590.0 8767.3 8900.4 9100.5 9106.6 4939.2 4954.0 4997.9 5117.8 5131.5 3379.4 3472.8 3497.4 3498.4 3501.8 616.3 635.6 635.8 648.4 653.3 698.4 753.0 783.7 788.6 801.1 9615.5 9683.3 9712.7 10378.7 10985.0 704.5 725.1 749.5 752.3 768.9 5108.1 5289.7 5297.2 5308.9 5310.6 73586.6 91142.5 99837.0 105867.0 106170.0 77334.6 89556.6 92068.5 92591.1 93816.0 75565.0 75700.0 75742.0 87660.0 88419.0 9442.9 9582.2 10140.5 10431.3 10620.6 52626.0 53264.5 53639.7 54084.0 54247.4 68439.3 77652.6 78574.6 79079.2 80710.4 12115.6 12358.8 12470.3 12652.1 12776.4 15023.9 15119.6 15252.8 15866.1 15942.1 13933.3 14533.8 14692.0 14889.9 15075.7 14136.6 14418.6 14733.5 14912.4 15313.0 14120.4 15423.5 15449.2 15467.6 15487.7 9671.0 9775.6 9905.4 10036.8 10049.9 9310.0 9729.3 9742.2 10251.3 10497.8 23:37:56 INFO - PROCESS | 318 | -------- Summary: end -------- 23:37:56 INFO - PROCESS | 318 | 23:37:57 INFO - TEST-INFO | 318: exit 0 23:37:57 INFO - TEST-OK | dromaeo_css | took 1115873ms 23:37:57 INFO - TEST-START | kraken 23:37:57 INFO - operating with platform_type : linux_ 23:37:57 INFO - Initialising browser for kraken test... 23:37:57 INFO - TEST-INFO | started process 632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GCnNi/profile http://localhost:44117/getInfo.html) 23:38:01 INFO - PROCESS | 632 | __metrics Screen width/height:1600/1200 23:38:01 INFO - PROCESS | 632 | colorDepth:24 23:38:01 INFO - PROCESS | 632 | Browser inner width/height: 1024/697 23:38:01 INFO - PROCESS | 632 | __metrics 23:38:02 INFO - PROCESS | 632 | 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" 23:38:02 INFO - PROCESS | 632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:38:02 INFO - PROCESS | 632 | console.error: PushService: 23:38:02 INFO - PROCESS | 632 | stateChangeProcessEnqueue: Error transitioning state 23:38:02 INFO - PROCESS | 632 | UnknownError 23:38:03 INFO - TEST-INFO | 632: exit 0 23:38:03 INFO - Browser initialized. 23:38:03 INFO - Running cycle 1/1 for kraken test... 23:38:03 INFO - TEST-INFO | started process 714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GCnNi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:15 INFO - PROCESS | 714 | RSS: Main: 179634176 23:38:15 INFO - PROCESS | 714 | 23:38:17 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44117/tests/kraken/driver.html?testName=audio-beat-detection) 23:38:18 INFO - PROCESS | 714 | RSS: Main: 232878080 23:38:18 INFO - PROCESS | 714 | 23:38:21 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44117/tests/kraken/driver.html?testName=audio-dft) 23:38:21 INFO - PROCESS | 714 | RSS: Main: 223592448 23:38:21 INFO - PROCESS | 714 | 23:38:25 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44117/tests/kraken/driver.html?testName=audio-fft) 23:38:25 INFO - PROCESS | 714 | RSS: Main: 302526464 23:38:25 INFO - PROCESS | 714 | 23:38:27 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44117/tests/kraken/driver.html?testName=audio-oscillator) 23:38:28 INFO - PROCESS | 714 | RSS: Main: 211664896 23:38:28 INFO - PROCESS | 714 | 23:38:30 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:38:31 INFO - PROCESS | 714 | RSS: Main: 213803008 23:38:31 INFO - PROCESS | 714 | 23:38:34 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44117/tests/kraken/driver.html?testName=imaging-darkroom) 23:38:34 INFO - PROCESS | 714 | RSS: Main: 253235200 23:38:34 INFO - PROCESS | 714 | 23:38:38 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44117/tests/kraken/driver.html?testName=imaging-desaturate) 23:38:38 INFO - PROCESS | 714 | RSS: Main: 251473920 23:38:38 INFO - PROCESS | 714 | 23:38:41 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44117/tests/kraken/driver.html?testName=json-parse-financial) 23:38:42 INFO - PROCESS | 714 | RSS: Main: 251346944 23:38:42 INFO - PROCESS | 714 | 23:38:43 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:38:44 INFO - PROCESS | 714 | RSS: Main: 214237184 23:38:44 INFO - PROCESS | 714 | 23:38:46 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:38:46 INFO - PROCESS | 714 | RSS: Main: 222027776 23:38:46 INFO - PROCESS | 714 | 23:38:48 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:38:49 INFO - PROCESS | 714 | RSS: Main: 222511104 23:38:49 INFO - PROCESS | 714 | 23:38:52 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:38:52 INFO - PROCESS | 714 | RSS: Main: 223391744 23:38:52 INFO - PROCESS | 714 | 23:38:55 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:38:55 INFO - PROCESS | 714 | RSS: Main: 220835840 23:38:55 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:44117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44117/tests/kraken/driver.html?testName=ai-astar) 23:38:57 INFO - PROCESS | 714 | RSS: Main: 272633856 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | __start_tp_report 23:38:57 INFO - PROCESS | 714 | _x_x_mozilla_page_load 23:38:57 INFO - PROCESS | 714 | _x_x_mozilla_page_load_details 23:38:57 INFO - PROCESS | 714 | |i|pagename|runs| 23:38:57 INFO - PROCESS | 714 | |0;ai-astar;110;111;127;111;111;111;112;111;111;109 23:38:57 INFO - PROCESS | 714 | |1;audio-beat-detection;144;117;146;169;118;155;150;121;183;121 23:38:57 INFO - PROCESS | 714 | |2;audio-dft;162;161;163;163;161;162;163;163;161;160 23:38:57 INFO - PROCESS | 714 | |3;audio-fft;75;75;76;174;76;76;76;75;172;76 23:38:57 INFO - PROCESS | 714 | |4;audio-oscillator;83;83;146;82;81;82;144;82;82;150 23:38:57 INFO - PROCESS | 714 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 23:38:57 INFO - PROCESS | 714 | |6;imaging-darkroom;146;146;146;146;146;146;146;158;145;145 23:38:57 INFO - PROCESS | 714 | |7;imaging-desaturate;96;94;95;95;96;95;95;95;95;95 23:38:57 INFO - PROCESS | 714 | |8;json-parse-financial;52;51;52;53;53;53;53;55;55;54 23:38:57 INFO - PROCESS | 714 | |9;json-stringify-tinderbox;62;64;63;64;63;63;63;64;64;64 23:38:57 INFO - PROCESS | 714 | |10;stanford-crypto-aes;79;79;87;79;84;78;85;79;79;79 23:38:57 INFO - PROCESS | 714 | |11;stanford-crypto-ccm;132;135;130;122;129;125;122;124;165;125 23:38:57 INFO - PROCESS | 714 | |12;stanford-crypto-pbkdf2;167;166;165;165;161;163;165;163;163;166 23:38:57 INFO - PROCESS | 714 | |13;stanford-crypto-sha256-iterative;70;64;66;66;65;65;64;67;64;63 23:38:57 INFO - PROCESS | 714 | __end_tp_report 23:38:57 INFO - PROCESS | 714 | __start_cc_report 23:38:57 INFO - PROCESS | 714 | _x_x_mozilla_cycle_collect,1769 23:38:57 INFO - PROCESS | 714 | __end_cc_report 23:38:57 INFO - PROCESS | 714 | __startTimestamp1472193537940__endTimestamp 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | ------- Summary: start ------- 23:38:57 INFO - PROCESS | 714 | Number of tests: 14 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#0] ai-astar Cycles:10 Average:112.40 Median:111.00 stddev:5.19 (4.7%) stddev-sans-first:5.43 23:38:57 INFO - PROCESS | 714 | Values: 110.0 111.0 127.0 111.0 111.0 111.0 112.0 111.0 111.0 109.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.00 stddev:22.96 (15.5%) stddev-sans-first:24.35 23:38:57 INFO - PROCESS | 714 | Values: 144.0 117.0 146.0 169.0 118.0 155.0 150.0 121.0 183.0 121.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 23:38:57 INFO - PROCESS | 714 | Values: 162.0 161.0 163.0 163.0 161.0 162.0 163.0 163.0 161.0 160.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:41.06 (54.0%) stddev-sans-first:42.90 23:38:57 INFO - PROCESS | 714 | Values: 75.0 75.0 76.0 174.0 76.0 76.0 76.0 75.0 172.0 76.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:82.00 stddev:31.21 (38.1%) stddev-sans-first:32.37 23:38:57 INFO - PROCESS | 714 | Values: 83.0 83.0 146.0 82.0 81.0 82.0 144.0 82.0 82.0 150.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:38:57 INFO - PROCESS | 714 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:146.00 stddev:3.89 (2.7%) stddev-sans-first:4.11 23:38:57 INFO - PROCESS | 714 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 158.0 145.0 145.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:38:57 INFO - PROCESS | 714 | Values: 96.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.29 (2.4%) stddev-sans-first:1.30 23:38:57 INFO - PROCESS | 714 | Values: 52.0 51.0 52.0 53.0 53.0 53.0 53.0 55.0 55.0 54.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 23:38:57 INFO - PROCESS | 714 | Values: 62.0 64.0 63.0 64.0 63.0 63.0 63.0 64.0 64.0 64.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.00 stddev:3.22 (4.1%) stddev-sans-first:3.35 23:38:57 INFO - PROCESS | 714 | Values: 79.0 79.0 87.0 79.0 84.0 78.0 85.0 79.0 79.0 79.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:129.50 stddev:12.74 (9.8%) stddev-sans-first:13.51 23:38:57 INFO - PROCESS | 714 | Values: 132.0 135.0 130.0 122.0 129.0 125.0 122.0 124.0 165.0 125.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:1.84 (1.1%) stddev-sans-first:1.69 23:38:57 INFO - PROCESS | 714 | Values: 167.0 166.0 165.0 165.0 161.0 163.0 165.0 163.0 163.0 166.0 23:38:57 INFO - PROCESS | 714 | 23:38:57 INFO - PROCESS | 714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:2.01 (3.1%) stddev-sans-first:1.27 23:38:57 INFO - PROCESS | 714 | Values: 70.0 64.0 66.0 66.0 65.0 65.0 64.0 67.0 64.0 63.0 23:38:57 INFO - PROCESS | 714 | -------- Summary: end -------- 23:38:57 INFO - PROCESS | 714 | 23:38:58 INFO - TEST-INFO | 714: exit 0 23:38:59 INFO - TEST-OK | kraken | took 61662ms 23:38:59 INFO - SUITE-END | took 1177s 23:38:59 INFO - Completed test suite (00:19:37) 23:38:59 INFO - javascript benchmark 23:38:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.4844776388004, 3047.5733397324366, 3050.7254347108765, 3077.923051923703, 3107.518334658129, 5141.974290128554, 5210.400803907552, 5255.973720131399, 5339.89320213596, 5388.91916621251, 5286.392064912527, 5289.814856480024, 5340.198970154469, 5361.115415956372, 5393.1370980643105, 4782.545658162487, 4806.182948898687, 4821.108095002418, 4831.323614693928, 5009.899802003976, 4901.754912254391, 4943.036107958949, 4954.182559877616, 4958.95861869008, 4978.452370239271, 4799.760011999386, 4847.321375007502, 4859.052484765472, 4905.730184839815, 4954.0, 4805.3753012108555, 4826.227803551415, 4829.1790395632825, 4862.416510018785, 4862.82980095695, 4806.855794326176, 4828.058528586892, 4833.951660483385, 4842.12841688496, 4900.044491324194, 5192.324997750268, 5385.5960802939935, 5389.703566303851, 5390.8382748517215, 5395.298611180521, 5618.803341883015, 5670.886582268332, 5681.602287839853, 5694.288213973254, 5699.886002279973, 5692.686902220376, 5725.513331366838, 5730.19777231188, 5731.025725626653, 5752.424757524256, 5247.003069416799, 5288.709120998382, 5347.41178470368, 5354.089804733166, 5356.11624082026, 5796.449337312949, 5822.621529600562, 5823.388544202882, 5893.5579831512805, 5937.495312898365, 5601.271834661549, 5638.2670252866865, 5639.041362968305, 5642.85892852682, 5644.32268127819, 5506.394296627368, 5571.192177134293, 5630.5495560355075, 5641.605087643826, 5644.604877658525, 5665.5184309333345, 5686.459786320293, 5702.144678298288, 5737.254156959569, 5767.913481297784, 5671.773129074873, 5706.600537962303, 5709.685967271756, 5709.771609135588, 5712.6286791358425, 4197.685173611992, 4319.8488052918, 4327.870163895088, 4328.415663885398, 4383.452068491439, 3945.112349721347, 3947.82234799429, 3986.80065996699, 4012.558618551957, 4040.8383664653675, 5457.672539647554, 5460.6996615186545, 5462.508374246337, 5466.890662186814, 5467.781288748405, 5613.186088017214, 5626.127950167731, 5811.157382179645, 5827.0, 5827.88344233113, 5292.364916210079, 5355.0, 5363.19552067193, 5400.405955344909, 5419.864503387368, 4884.218525035977, 4894.339264199359, 4901.534354236342, 4924.3105965164905, 4950.455449900508, 5708.372079071216, 5821.970890145607, 5834.649921004753, 5846.795362162304, 5882.441168089024, 5788.363280039108, 5830.854228644318, 5833.562482813891, 5880.617759845596, 5901.734421951109, 5931.851703707442, 5936.7922122725495, 5948.10778383246, 5951.137085122719, 5988.5508586855285, 5492.972535137299, 5617.241672374177, 5692.658440493584, 5694.117411801178, 5699.857503562278, 5705.828825135252, 5749.195112684311, 5760.711964401679, 5849.64902105875, 5851.1515830205235, 5613.494785469327, 5614.5789065821045, 5616.915746263891, 5623.0, 5623.578231632562, 5485.561155107662, 5524.613277070727, 5585.860353491195, 5587.69267690281, 5591.916121258103, 5565.693886836263, 5598.0, 5605.383407825055, 5655.915161272502, 5658.151277308437, 5588.329400471969, 5610.382857885547, 5614.101743720985, 5624.746886390204, 5631.8592035199445, 5339.172428273624, 5345.705986170798, 5484.945150548443, 5492.368377636463, 5494.560435165097], "value": 5269.269322397215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6059398284494, 585.1427658480326, 600.762698734, 607.7083000159926, 622.3993845938668, 41756.58243417565, 43466.0, 43710.344344834855, 43830.342544861815, 47028.76485617576, 44797.328040079425, 45237.547624523744, 45291.54708452914, 45322.0, 45379.0, 8234.135415781346, 8982.730518084436, 9127.452352858816, 9134.314926380548, 10621.309614875046, 10358.792824143513, 10740.0, 10741.892581074206, 10786.622468213614, 10786.73033174173, 10890.128789696806, 10930.0, 10936.56253749853, 10944.288621239633, 10945.83581246282, 10836.403997780119, 10854.72863178423, 10866.891331086747, 10867.45662716861, 10881.12950963921, 10776.40729759863, 10809.83785243222, 10841.457927103613, 10855.077318427942, 10856.511456984455, 42281.36577951333, 42610.78694606538, 42654.78672606617, 42674.359884601756, 42687.7865610673, 3488.4244099723514, 3572.214112895185, 3964.8414063437426, 4139.937900931488, 4214.178235244129, 32502.512462313083, 33013.0, 33066.17334566631, 33126.503102453484, 33134.17164570881, 4403.801828917706, 4413.29387298034, 4499.100179963988, 4517.254652982254, 4550.943622191848, 257136.0, 259108.0, 259163.0, 260822.0, 261420.0, 48533.0, 48753.51246487561, 48782.75608621934, 48805.0, 48855.511444885095, 59603.40396596065, 59810.70094649499, 59947.405785363575, 60018.39981600215, 60021.69989150026, 15527.146006969726, 15575.766363504557, 15715.921420392824, 15724.764128538081, 15729.842701573067, 9956.352837065568, 12564.685882852818, 13043.804342934864, 13098.934505327412, 13342.533011344556, 15633.530994070195, 15693.215339232993, 15723.0, 15742.212889355487, 15840.28718707638, 5843.152742852262, 5972.134040564094, 5981.730822113015, 6021.217241758631, 6022.675011497464, 794.9006374203225, 1016.7559785651538, 1031.8452232165234, 1108.6286094158547, 1120.6974116988367, 31462.528062079087, 32145.357092858012, 32156.678433215835, 32334.0, 32861.67138328634, 1095.5453486803046, 1102.6361300770727, 1110.9333439993627, 1170.5142365918218, 1177.252444697623, 15412.691746165014, 16228.350865965465, 16254.674906501803, 16264.349426022827, 16493.0, 473897.0, 477355.0, 478252.0, 478947.0, 479198.0, 55912.0, 55946.72026639922, 55995.0, 56099.71950140223, 56106.438935610124, 1239.070696977267, 1349.9932500337632, 1350.0, 1367.282176857158, 1372.1629805818243, 32232.83883580567, 33762.3247535043, 34324.31351372909, 34434.31131377409, 34523.30953380968, 48903.510964889894, 48982.5101748978, 49190.75404623097, 49315.0, 49474.50525494699, 370696.0, 372297.0, 372522.0, 372960.0, 373485.0, 28801.71198288074, 29473.410531789672, 29597.556036659036, 29653.703462965095, 29787.404251915275, 48695.51304487052, 48928.75535622299, 49047.0, 49524.50475495343, 49630.25554616756, 40871.79564102161, 41112.38331424971, 41289.94846005, 41888.0, 43556.34665479957, 39605.80197098996, 40276.3958540628, 40336.05907942577, 40606.0, 40869.79565102155, 40244.597554025255, 41817.79091104525, 42380.36429453622, 42495.0, 44965.77517112524, 32675.34649307048, 36673.266534668626, 36751.54714415753, 39735.0, 40356.59643403528, 28456.57315140316, 28620.57069143923, 28688.569671455363, 28742.425151496434, 28852.567211491423], "value": 20037.97490951956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.3983346977896, 385.61245947822437, 397.92041591681664, 400.72149855850176, 404.5509484472235, 16683.165841707912, 19409.02954852257, 19464.610707785872, 19606.411807645774, 20512.8974355128, 19902.0, 20162.798372016274, 20304.18783248668, 20365.694514582294, 20503.794962050375, 5217.5565076968505, 5764.077747560391, 5927.347991720907, 5967.403259674042, 5991.550633702468, 5869.618474799146, 5957.344692083867, 5964.314103878066, 5965.46310832025, 5971.581989260753, 5634.436556344353, 5872.7063646817705, 5875.559333050017, 5908.911366329508, 6000.489958353545, 5706.828795136111, 5844.152597873306, 5890.911636325459, 5900.232969713931, 5901.793437229698, 5637.7181140942785, 5694.0, 5696.088625819891, 5699.8005069822775, 5701.25883635129, 14238.359273832599, 14385.907029988499, 23275.301740947798, 23951.16170934009, 24116.879415602983, 2227.6881236626887, 2582.1607977407416, 2723.400851812598, 2759.1584566707147, 2937.0748214312425, 10623.734406639818, 10751.892481075167, 11748.882511174865, 12453.501859925593, 15531.767023494656, 1864.3288416170167, 1878.8402985746227, 1882.6526296935779, 1950.5903760210372, 1987.8707883987495, 81377.0, 87694.12305876924, 87814.56092719559, 88324.0, 89677.55161224153, 11133.165012624086, 11293.71765705864, 11472.426378681033, 11698.2981021139, 11806.586769463027, 16219.594510137342, 16247.943883647526, 16266.75599866003, 16282.918585406996, 16287.185640718153, 8091.55496447701, 8177.386695997705, 8397.538135402488, 8419.07390187079, 8470.534120623302, 7448.625957924495, 7452.515586486969, 7647.273509016634, 7839.294463498312, 8284.337253019745, 4750.833720819824, 4816.373871396696, 4882.902341953141, 4953.405591329064, 4955.306257124005, 1929.9614007719767, 1972.8056632529103, 1984.9206031758567, 1993.451800754775, 2008.2368699893948, 894.2667013049368, 931.888173419194, 951.2770294576034, 966.8936416994125, 1037.6523864505325, 18563.35028274004, 19985.30051448192, 20072.49818754543, 20113.39659810208, 20590.485237869172, 940.9247260219166, 961.6538046303325, 977.2328721953232, 988.5749127875083, 992.5186284651938, 10555.208359373079, 10863.130949524018, 11124.0, 11138.777224455465, 11178.608748693756, 480921.0, 482636.0, 488409.0, 494328.0, 504946.0, 83003.0, 90308.0, 100347.49826250822, 101027.49486252521, 102111.48944255231, 983.3215081593678, 1020.4897551224387, 1045.7281106912258, 1050.7635781949, 1057.94710264488, 17841.375551855625, 17883.37408190707, 18734.718979215595, 18775.781703739827, 18847.340343087926, 33918.66081339155, 42809.357859631506, 42887.35668964906, 44218.557814421445, 45343.09313813639, 59212.0, 59510.40489595049, 61378.693106534185, 63011.684941575, 63736.04395933972, 8630.78423039404, 8666.480011199348, 8764.462562196379, 8788.736337909873, 8897.644094236159, 12113.878861211275, 12558.434870431036, 12693.936530317658, 13633.795493067413, 13684.45262189541, 11660.0, 11854.822177667515, 11980.520779168735, 12096.818547721967, 12172.695682608006, 11364.602238921598, 11749.118816088998, 11809.704757381134, 11836.704082397664, 12051.035917126785, 12017.098717596391, 12043.277403355827, 12065.09511786637, 12374.257544547356, 12468.251904885736, 7522.962385188039, 7540.17058123617, 7839.725609603636, 8583.399162058597, 8642.265407440438, 8544.957275213585, 11654.0, 11826.940865295619, 11846.170768046153, 11992.280463172237], "value": 9386.093527367317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.1276170489175, 1439.8128243328365, 1478.6229511474576, 1574.23649529978, 1760.7446920196571, 8006.199380061991, 8371.414001019932, 8438.156184381567, 8618.095100014501, 8629.525376104311, 8415.28470080044, 8501.0, 8510.70212542561, 8519.701810436636, 8522.360822938273, 2354.635031570105, 2377.215518878766, 2380.7619238076227, 2381.1784934197676, 2385.224801939368, 2285.074544809355, 2362.0669835415, 2363.0311572255378, 2369.0642196332524, 2369.1707902234252, 2336.707911511061, 2358.5047140100514, 2360.9645855312183, 2374.157174203159, 2375.228050883461, 2272.329662749493, 2298.8275879309117, 2305.3199306204624, 2312.028947841902, 2324.8721320327377, 2268.3421807675754, 2274.715660542432, 2275.260540324401, 2278.874661893595, 2280.5780930527903, 8348.039975402846, 8490.74527764162, 8581.184787445183, 8590.957045214735, 8596.570171491401, 5032.345795046621, 5228.843134705965, 5240.7379631018675, 5268.315119034501, 5274.55166310864, 3194.4409728297687, 3344.4782623906062, 3352.8491217895253, 3403.183236023361, 3422.6235114137426, 1198.9400529973466, 1217.379136640311, 1223.4188760338857, 1231.9836135188505, 1242.5588915934804, 11718.296902185812, 11740.706482337924, 11800.763984720343, 11802.232854864493, 11821.408929553489, 4158.750474971512, 4348.478182618106, 4460.375547423363, 4531.750753708512, 4560.156371071363, 9188.402753821114, 9190.356675032817, 9191.402558833654, 9195.862062069074, 9258.90741092594, 5073.8731531712, 5084.567811736044, 5100.158473851847, 5125.718085505258, 5128.0, 4177.373393990925, 4617.0996655651825, 4668.5098064702715, 4712.552307530779, 4782.852115492256, 3531.134871956387, 3572.160542272564, 3655.3054919565197, 3660.8352624131976, 3698.8335524901445, 1109.983350249747, 1117.3240139790314, 1123.8763735989035, 1128.4865386249237, 1132.8470656461272, 747.7345542332503, 847.8304339132075, 964.8118616869783, 973.8198433289864, 1007.6120693532896, 5464.617351908367, 5526.419725928719, 5575.609707320448, 5649.915251271234, 6111.327753947062, 456.3702091114241, 466.58774137708133, 467.847949416441, 489.65479337067285, 650.7343217442029, 3882.611738826095, 3963.4451176835264, 3994.78028708418, 4008.4187792769885, 4070.357030457724, 9607.903920960702, 10293.897061029444, 10448.947755261175, 10460.843087353696, 10475.738106547396, 10129.999999999853, 10316.948415257875, 10361.792764144826, 10377.066064054272, 10377.377357358582, 7782.105057918412, 7917.168697286817, 7940.6029698515995, 7944.682212711542, 7945.0, 5624.74688639004, 5642.322921249476, 5644.943550564606, 5675.120356344773, 5829.883402332014, 9546.0, 9614.086661767122, 9645.565949532429, 9687.709368718668, 9732.46471444049, 9609.51952402391, 9660.565274562801, 9694.85457718149, 9884.85172722424, 9898.455584942898, 7171.103612048494, 7223.891641625485, 7235.480549084751, 7237.0, 7237.3486386225495, 8202.630881610461, 8241.25828675398, 8243.25810677042, 8247.835043298981, 8273.875891861506, 7399.593022383605, 7539.0576177977755, 7564.810879728051, 7618.657160427683, 7717.305442509976, 7222.277772222736, 7339.633018349168, 7365.8158546036775, 7576.507527010726, 7603.163651998165, 6439.839004024937, 6554.934450655433, 6571.441427478718, 6574.539782215199, 6577.638229897401, 5093.439721630692, 5225.346831646044, 5240.109181439088, 5320.5477534408465, 5409.918851217156, 5040.117979353672, 5333.893322133613, 5369.087255166709, 5378.596605254544, 5395.622306438511], "value": 4422.98427215333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8437665543884, 324.10708498087763, 329.54193670797594, 332.17785979700227, 333.25184959765346, 5301.257823904652, 5360.624756267053, 5362.168863826103, 5367.677939323638, 5370.133503877207, 5213.244079608455, 5231.189165679316, 5238.240455134013, 5283.2867562879, 5299.33758280215, 3881.6312450317314, 4163.39630753542, 4164.7709375984305, 4167.708260421772, 4175.227582897159, 4116.382542618616, 4125.731827431207, 4139.275626765319, 4146.751194928299, 4154.231467178566, 4066.909149046731, 4076.6331030207275, 4087.795610219492, 4088.7342322748927, 4125.443065186191, 3903.609639036102, 3913.1391093959282, 4061.390791381287, 4097.938530922039, 4113.91772164555, 3517.6834084932225, 3529.38235808735, 3539.486774417721, 3543.273628906068, 3570.5715314162208, 5062.443131255559, 5068.163752980754, 5074.314967479417, 5094.61790365724, 5149.348085735812, 4291.50647675515, 4371.934420983688, 4508.278675411952, 4641.0, 4664.626829853603, 5417.943501017303, 5419.617997410674, 5420.539254163361, 5440.259117082535, 5468.371137319219, 3884.902877428087, 3905.785181814999, 3921.117748506592, 3942.6057394260633, 3951.150502641946, 5452.754626041838, 5692.48767610917, 5712.771489140471, 5758.827235182951, 5804.9419505805245, 4010.318245898204, 4018.8593399230886, 4022.879313620596, 4024.3561030235023, 4031.3952907064177, 4073.716779214538, 4081.0616356223472, 4082.6937979651643, 4091.774952377648, 4093.488313960755, 4523.479799823062, 4691.62467002639, 4700.600448961808, 4706.247000479907, 4720.395065677618, 5490.533304669068, 5490.615656903979, 5519.199716041232, 5523.177351474004, 5592.832215033555, 1377.827771528559, 1390.3107724115248, 1400.3838311143065, 1408.1269612840106, 1408.5211028250444, 846.3187134356901, 894.552723638181, 902.4089221559758, 915.2174890468686, 915.9038300978301, 4613.653975951817, 4671.95328046722, 4719.339292499053, 4733.219018861918, 4739.454962679336, 4962.082014827269, 4976.726280054631, 4978.8755281118265, 5052.898942021139, 5069.400725484947, 4750.358701575312, 4761.47623761386, 4762.118918054596, 4797.352357431771, 5030.949690503048, 2870.0, 2923.97076029237, 2972.524396096614, 2990.4019196160857, 3034.2717747740385, 5836.8540786479825, 5854.912176317359, 5872.442117998783, 5905.409459054146, 5905.675187864623, 5615.719214039282, 5806.30324361071, 5827.3298570664065, 5828.388019257917, 5838.241028666246, 5826.41735826414, 5875.706214689163, 5881.500362345901, 5886.087656413263, 5894.8821023579285, 5577.60956733041, 5622.550195984393, 5650.29371328584, 5658.830235092953, 5686.242172546395, 5382.757775900016, 5596.272484576979, 5597.888042239214, 5620.690862002629, 5623.184638227516, 5825.94174058271, 5830.2129212555765, 5833.4749872511675, 5835.241418615553, 5866.178734977021, 3982.820773065161, 4035.878923632296, 4037.5962403760564, 4044.1102957349335, 4045.7977101145416, 5437.809676661298, 5621.718914054362, 5629.521490673339, 5634.408387119457, 5666.716664166693, 5431.565474762088, 5453.7818487260065, 5473.616846820843, 5484.972575137099, 5495.945040549544, 5271.578273738169, 5453.890922181614, 5496.285482887199, 5499.642523235977, 5510.256115424367, 5452.509274165344, 5473.31583552056, 5474.562035037267, 5496.367917689357, 5498.670079795225, 5496.422875598005, 5499.312585926759, 5512.751926163252, 5522.641028333145, 5560.6107572471155, 5200.557952574073, 5329.782125477185, 5363.490468405495, 5452.454754524516, 5459.781608735765], "value": 4150.785162712093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.5327920049967, 757.3032809814973, 774.5004472115486, 816.261283538398, 878.2359347367789, 14993.700125997473, 15502.22488875556, 16634.66730665389, 16908.1545922704, 16909.7463538047, 15439.614009649764, 15483.69032619347, 15512.069275843458, 15522.068675879455, 15643.530694079167, 666.4202144134609, 794.4915254237293, 811.1563973467587, 814.9592520373988, 815.2621877201143, 794.3010151067053, 831.7795784117213, 833.737372727592, 840.5671079394117, 840.6385254340631, 870.7561882672861, 872.8559787635032, 873.4409977614332, 873.7247766953421, 873.7640836974045, 696.5472442912147, 869.9347548933855, 871.651339464213, 872.4503562755456, 872.9301655867515, 603.1043899808781, 619.102301662591, 621.561798931752, 627.7394881124374, 628.2868943748878, 15221.771673424908, 15255.923720381437, 15261.084334939938, 15283.159426231552, 15366.0, 13963.371648275852, 14272.785908211385, 14530.854691453162, 14551.322667511458, 14633.0, 13327.267000315076, 13434.932825335909, 13589.456421743118, 13779.793303100461, 13885.236312002937, 4402.889927751799, 4457.821687132511, 4464.419625448671, 4467.5755803198645, 4515.277555591122, 82214.0, 83197.58401207955, 83271.5836420814, 83380.0, 85886.57056714738, 11241.60654377093, 11246.7188320291, 11418.714532136763, 11504.827427588592, 11533.826992595117, 21787.0, 21841.0, 21862.453438663844, 21862.562748744935, 21881.452963676034, 8589.957050214709, 8767.254783343487, 8900.42147260426, 9100.453972761656, 9106.590203440861, 4939.185034469344, 4953.950460495421, 4997.90004199914, 5117.8464646060675, 5131.538161565402, 3379.425497665403, 3472.808995505221, 3497.4229252173614, 3498.3877821381157, 3501.77238479498, 616.3097330989231, 635.5900444213456, 635.8219698484431, 648.4067078623101, 653.258551544001, 698.4063545985871, 752.9661165247577, 783.6591082878966, 788.6332855222349, 801.1147681811631, 9615.51922403891, 9683.32216744821, 9712.660056897974, 10378.688639340831, 10985.0, 704.4681265644406, 725.1044959475045, 749.4978364495801, 752.2627824731684, 768.8961990131261, 5108.131617625013, 5289.709066001406, 5297.152455607084, 5308.867278318073, 5310.628256022042, 73586.63206683932, 91142.54428727814, 99837.0, 105867.0, 106170.0, 77334.61332693414, 89556.5522172385, 92068.53965730128, 92591.0740892596, 93816.0, 75565.0, 75700.0, 75741.9999999989, 87660.0, 88419.0, 9442.905570944202, 9582.233421326417, 10140.543675534765, 10431.321964072311, 10620.575176992834, 52626.0, 53264.46735532595, 53639.73180134074, 54084.0, 54247.405363248385, 68439.31560684329, 77652.61173694095, 78574.607126964, 79079.20920790719, 80710.36803343981, 12115.575954841539, 12358.81461778092, 12470.314132722788, 12652.114351995271, 12776.36118194068, 15023.924880375529, 15119.622009449851, 15252.771208432105, 15866.127362994685, 15942.123183225034, 13933.303334833015, 14533.78199327032, 14692.045017073857, 14889.85110148928, 15075.698486030436, 14136.575902722934, 14418.639534011734, 14733.484328048895, 14912.403503859725, 15313.0, 14120.435182592992, 15423.537293881202, 15449.227538623249, 15467.613309667347, 15487.690246195238, 9670.951645241728, 9775.608975640895, 9905.405675659484, 10036.799264014824, 10049.899501004897, 9310.0, 9729.318947673595, 9742.220622350053, 10251.333663311862, 10497.842532361869], "value": 7707.505247437484, "unit": "score"}], "name": "dromaeo_css", "value": 7208.021915888284, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 127.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 109.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 146.0, 169.0, 118.0, 155.0, 150.0, 121.0, 183.0, 121.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 161.0, 162.0, 163.0, 163.0, 161.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 174.0, 76.0, 76.0, 76.0, 75.0, 172.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 146.0, 82.0, 81.0, 82.0, 144.0, 82.0, 82.0, 150.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 158.0, 145.0, 145.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 53.0, 53.0, 53.0, 53.0, 55.0, 55.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 87.0, 79.0, 84.0, 78.0, 85.0, 79.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 130.0, 122.0, 129.0, 125.0, 122.0, 124.0, 165.0, 125.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 165.0, 161.0, 163.0, 165.0, 163.0, 163.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 66.0, 66.0, 65.0, 65.0, 64.0, 67.0, 64.0, 63.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1530.2000000000003, "alertThreshold": 2.0}]} 23:38:59 INFO - Return code: 0 23:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:38:59 INFO - # TBPL SUCCESS # 23:38:59 INFO - Running post-action listener: _resource_record_post_action 23:38:59 INFO - [mozharness: 2016-08-26 06:38:59.255174Z] Finished run-tests step (success) 23:38:59 INFO - Running post-run listener: _resource_record_post_run 23:38:59 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418607104; Read time: 12; Write time: 290432 23:38:59 INFO - TinderboxPrint: CPU usage
13.1% 23:38:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:38:59 INFO - TinderboxPrint: I/O write bytes / time
418,607,104 / 290,432 23:38:59 INFO - TinderboxPrint: CPU idle
8,288.0 (86.9%) 23:38:59 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 23:38:59 INFO - TinderboxPrint: Swap in / out
0 / 0 23:38:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 129212416; Read time: 0; Write time: 88484 23:38:59 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288780288; Read time: 12; Write time: 201948 23:38:59 INFO - Running post-run listener: _upload_blobber_files 23:38:59 INFO - Blob upload gear active. 23:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:38:59 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 23:38:59 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'] 23:38:59 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 23:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:01 INFO - (blobuploader) - INFO - Done attempting. 23:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:01 INFO - (blobuploader) - INFO - Done attempting. 23:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:05 INFO - (blobuploader) - INFO - Done attempting. 23:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:39:05 INFO - Return code: 0 23:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5eb405c37dc1342a0d659661288e4cea6cc557c228421ac063309368080f6bd70d1d8896cdb04172ea48fb02fbcb045239b07147c2e7b53a49c51b9c204268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/013d8bfed6fe2d73394475720c4555ff01c09060faddfb2f8a329757cc6702be4381106aad426992cadb398cd412b2e305d88732318df0b3e757f2095a8de789", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/213d77aa5943cd6a7c5c5c03d3a73ecefbf8244f53d9f6438cd328057fae5b2333a2653cd0bb795ec261b221a042608133672df3adf8804eded8ab460a6802fb"} 23:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:39:05 INFO - Contents: 23:39:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5eb405c37dc1342a0d659661288e4cea6cc557c228421ac063309368080f6bd70d1d8896cdb04172ea48fb02fbcb045239b07147c2e7b53a49c51b9c204268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/013d8bfed6fe2d73394475720c4555ff01c09060faddfb2f8a329757cc6702be4381106aad426992cadb398cd412b2e305d88732318df0b3e757f2095a8de789", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/213d77aa5943cd6a7c5c5c03d3a73ecefbf8244f53d9f6438cd328057fae5b2333a2653cd0bb795ec261b221a042608133672df3adf8804eded8ab460a6802fb"} 23:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:39:05 INFO - Copying logs to upload dir... 23:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.264143 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 23:39:05.126506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 23:39:05.130611) ========= 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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 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/d5eb405c37dc1342a0d659661288e4cea6cc557c228421ac063309368080f6bd70d1d8896cdb04172ea48fb02fbcb045239b07147c2e7b53a49c51b9c204268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/013d8bfed6fe2d73394475720c4555ff01c09060faddfb2f8a329757cc6702be4381106aad426992cadb398cd412b2e305d88732318df0b3e757f2095a8de789", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/213d77aa5943cd6a7c5c5c03d3a73ecefbf8244f53d9f6438cd328057fae5b2333a2653cd0bb795ec261b221a042608133672df3adf8804eded8ab460a6802fb"} build_url:https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/NemTCa2qS9eS9gbYxMt7rg/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/d5eb405c37dc1342a0d659661288e4cea6cc557c228421ac063309368080f6bd70d1d8896cdb04172ea48fb02fbcb045239b07147c2e7b53a49c51b9c204268e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/013d8bfed6fe2d73394475720c4555ff01c09060faddfb2f8a329757cc6702be4381106aad426992cadb398cd412b2e305d88732318df0b3e757f2095a8de789", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/213d77aa5943cd6a7c5c5c03d3a73ecefbf8244f53d9f6438cd328057fae5b2333a2653cd0bb795ec261b221a042608133672df3adf8804eded8ab460a6802fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 23:39:05.156523) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:39:05.156909) ========= 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=652eb03db935cfc1c15ebda0000001ad-1472192025.152747-1178770335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 23:39:05.242400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 23:39:05.242761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 23:39:05.243115) ========= ========= Total master_lag: 0.18 =========