builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1471630646.68 results: success (0) buildid: 20160819102824 builduid: 3e06750bcfb24b8aa952519e26568ca1 revision: 6b1f62a32be285d0d8956629b2860fb5212bc8de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.675695) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.676177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.676465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.697217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.697482) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 11:17:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-08-19 11:17:27 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.839077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.839365) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.892640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:26.893024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b1f62a32be285d0d8956629b2860fb5212bc8de --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 6b1f62a32be285d0d8956629b2860fb5212bc8de --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=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 11:17:27,482 truncating revision to first 12 chars 2016-08-19 11:17:27,482 Setting DEBUG logging. 2016-08-19 11:17:27,482 attempt 1/10 2016-08-19 11:17:27,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b1f62a32be2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 11:17:27,791 unpacking tar archive at: fx-team-6b1f62a32be2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:27.584870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:27.585218) ========= script_repo_revision: 6b1f62a32be285d0d8956629b2860fb5212bc8de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:27.585618) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:27.585888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 11:17:27.597438) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-19 11:17:27.597735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:28 INFO - MultiFileLogger online at 20160819 11:17:28 in /builds/slave/test 11:17:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:17:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:28 INFO - {'append_to_log': False, 11:17:28 INFO - 'base_work_dir': '/builds/slave/test', 11:17:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:17:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:28 INFO - 'branch': 'Fx-Team-Non-PGO', 11:17:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:28 INFO - 'config_files': ('talos/linux_config.py',), 11:17:28 INFO - 'default_actions': ('clobber', 11:17:28 INFO - 'read-buildbot-config', 11:17:28 INFO - 'download-and-extract', 11:17:28 INFO - 'populate-webroot', 11:17:28 INFO - 'create-virtualenv', 11:17:28 INFO - 'install', 11:17:28 INFO - 'run-tests'), 11:17:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:28 INFO - 'download_minidump_stackwalk': True, 11:17:28 INFO - 'download_symbols': 'ondemand', 11:17:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:28 INFO - 'installer_path': 'installer.exe', 11:17:28 INFO - 'log_level': 'info', 11:17:28 INFO - 'log_name': 'talos', 11:17:28 INFO - 'log_to_console': True, 11:17:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:28 INFO - 'opt_config_files': (), 11:17:28 INFO - 'pip_index': False, 11:17:28 INFO - 'sps_profile': False, 11:17:28 INFO - 'sps_profile_interval': 0, 11:17:28 INFO - 'suite': 'dromaeojs-e10s', 11:17:28 INFO - 'system_bits': '32', 11:17:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:28 INFO - 'title': 'talos-linux64-ix-061', 11:17:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:28 INFO - 'use_talos_json': True, 11:17:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:28 INFO - 'work_dir': 'build'} 11:17:28 INFO - [mozharness: 2016-08-19 18:17:28.285556Z] Running clobber step. 11:17:28 INFO - Running pre-action listener: _resource_record_pre_action 11:17:28 INFO - Running main action method: clobber 11:17:28 INFO - rmtree: /builds/slave/test/build 11:17:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:28 INFO - Running post-action listener: _resource_record_post_action 11:17:28 INFO - [mozharness: 2016-08-19 18:17:28.747824Z] Finished clobber step (success) 11:17:28 INFO - [mozharness: 2016-08-19 18:17:28.747926Z] Running read-buildbot-config step. 11:17:28 INFO - Running pre-action listener: _resource_record_pre_action 11:17:28 INFO - Running main action method: read_buildbot_config 11:17:28 INFO - Using buildbot properties: 11:17:28 INFO - { 11:17:28 INFO - "project": "", 11:17:28 INFO - "product": "firefox", 11:17:28 INFO - "script_repo_revision": "production", 11:17:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:17:28 INFO - "repository": "", 11:17:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:17:28 INFO - "buildid": "20160819102824", 11:17:28 INFO - "pgo_build": "False", 11:17:28 INFO - "basedir": "/builds/slave/test", 11:17:28 INFO - "buildnumber": 1559, 11:17:28 INFO - "slavename": "talos-linux64-ix-061", 11:17:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:17:28 INFO - "platform": "ubuntu64_hw", 11:17:28 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 11:17:28 INFO - "branch": "fx-team", 11:17:28 INFO - "repo_path": "integration/fx-team", 11:17:28 INFO - "revision": "6b1f62a32be285d0d8956629b2860fb5212bc8de", 11:17:28 INFO - "stage_platform": "linux64", 11:17:28 INFO - "builduid": "3e06750bcfb24b8aa952519e26568ca1", 11:17:28 INFO - "slavebuilddir": "test" 11:17:28 INFO - } 11:17:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:17:28 INFO - Running post-action listener: _resource_record_post_action 11:17:28 INFO - [mozharness: 2016-08-19 18:17:28.750368Z] Finished read-buildbot-config step (success) 11:17:28 INFO - [mozharness: 2016-08-19 18:17:28.750456Z] Running download-and-extract step. 11:17:28 INFO - Running pre-action listener: _resource_record_pre_action 11:17:28 INFO - Running main action method: download_and_extract 11:17:28 INFO - mkdir: /builds/slave/test/build/tests 11:17: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')]} 11:17:28 INFO - trying https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:17:29 INFO - Downloaded 1361 bytes. 11:17:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:29 INFO - Using the following test package requirements: 11:17:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:17:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'jsshell-linux-x86_64.zip'], 11:17:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:29 INFO - trying https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:30 INFO - Downloaded 20329032 bytes. 11:17:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:17:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:34 INFO - trying https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:35 INFO - Downloaded 20329032 bytes. 11:17:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - trying https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:17:40 INFO - Downloaded 14413981 bytes. 11:17:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:41 INFO - trying https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:17:42 INFO - Downloaded 55766683 bytes. 11:17:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:42 INFO - mkdir: /builds/slave/test/properties 11:17:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:42 INFO - Contents: 11:17:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:42 INFO - Running post-action listener: _resource_record_post_action 11:17:42 INFO - Running post-action listener: set_extra_try_arguments 11:17:42 INFO - [mozharness: 2016-08-19 18:17:42.974704Z] Finished download-and-extract step (success) 11:17:42 INFO - [mozharness: 2016-08-19 18:17:42.975001Z] Running populate-webroot step. 11:17:42 INFO - Running pre-action listener: _resource_record_pre_action 11:17:42 INFO - Running main action method: populate_webroot 11:17:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:42 INFO - '--tppagecycles', 11:17:42 INFO - '7'], 11:17:42 INFO - 'tests': ['tsvgm']}}, 11:17:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['damp', 'tps']}, 11:17:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'tests': ['damp', 'tps']}, 11:17:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['dromaeo_dom']}, 11:17:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['basic_compositor_video']}, 11:17:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:17:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['a11yr', 11:17:42 INFO - 'ts_paint', 11:17:42 INFO - 'tpaint', 11:17:42 INFO - 'sessionrestore', 11:17:42 INFO - 'sessionrestore_no_auto_restore', 11:17:42 INFO - 'tabpaint']}, 11:17:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['tsvgx', 11:17:42 INFO - 'tsvgr_opacity', 11:17:42 INFO - 'tart', 11:17:42 INFO - 'tscrollx', 11:17:42 INFO - 'cart']}, 11:17:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:42 INFO - 'tsvgr_opacity', 11:17:42 INFO - 'tart', 11:17:42 INFO - 'tscrollx', 11:17:42 INFO - 'cart']}, 11:17:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'talos_options': ['--disable-e10s'], 11:17:42 INFO - 'tests': ['tp5o']}, 11:17:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'tests': ['tp5o']}, 11:17:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'talos_options': ['--disable-e10s', 11:17:42 INFO - '--xperf_path', 11:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:42 INFO - 'tests': ['tp5n']}, 11:17:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:42 INFO - 'talos_options': ['--xperf_path', 11:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:42 INFO - 'tests': ['tp5n']}}, 11:17:42 INFO - 'talos.zip': {'path': '', 11:17:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:42 INFO - Running post-action listener: _resource_record_post_action 11:17:42 INFO - [mozharness: 2016-08-19 18:17:42.996326Z] Finished populate-webroot step (success) 11:17:42 INFO - [mozharness: 2016-08-19 18:17:42.996419Z] Running create-virtualenv step. 11:17:42 INFO - Running pre-action listener: _resource_record_pre_action 11:17:42 INFO - Running main action method: create_virtualenv 11:17:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:17:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:43 INFO - Using real prefix '/usr' 11:17:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:45 INFO - Installing pip.................done. 11:17:45 INFO - Return code: 0 11:17:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:17:45 INFO - Using env: {'DISPLAY': ':0', 11:17:45 INFO - 'HOME': '/home/cltbld', 11:17:45 INFO - 'LANG': 'en_US.UTF-8', 11:17:45 INFO - 'LANGUAGE': 'en_US:en', 11:17:45 INFO - 'LOGNAME': 'cltbld', 11:17:45 INFO - 'MAIL': '/var/mail/cltbld', 11:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:45 INFO - 'MOZ_NO_REMOTE': '1', 11:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:45 INFO - 'NO_EM_RESTART': '1', 11:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:45 INFO - 'PWD': '/builds/slave/test', 11:17:45 INFO - 'SHELL': '/bin/bash', 11:17:45 INFO - 'SHLVL': '1', 11:17:45 INFO - 'TERM': 'linux', 11:17:45 INFO - 'TMOUT': '86400', 11:17:45 INFO - 'USER': 'cltbld', 11:17:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:45 INFO - '_': '/tools/buildbot/bin/python'} 11:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:17:45 INFO - Cleaning up... 11:17:45 INFO - Return code: 0 11:17:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:17:45 INFO - Using env: {'DISPLAY': ':0', 11:17:45 INFO - 'HOME': '/home/cltbld', 11:17:45 INFO - 'LANG': 'en_US.UTF-8', 11:17:45 INFO - 'LANGUAGE': 'en_US:en', 11:17:45 INFO - 'LOGNAME': 'cltbld', 11:17:45 INFO - 'MAIL': '/var/mail/cltbld', 11:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:45 INFO - 'MOZ_NO_REMOTE': '1', 11:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:45 INFO - 'NO_EM_RESTART': '1', 11:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:45 INFO - 'PWD': '/builds/slave/test', 11:17:45 INFO - 'SHELL': '/bin/bash', 11:17:45 INFO - 'SHLVL': '1', 11:17:45 INFO - 'TERM': 'linux', 11:17:45 INFO - 'TMOUT': '86400', 11:17:45 INFO - 'USER': 'cltbld', 11:17:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:45 INFO - '_': '/tools/buildbot/bin/python'} 11:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:45 INFO - Downloading/unpacking psutil>=3.1.1 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:47 INFO - Installing collected packages: psutil 11:17:47 INFO - Running setup.py install for psutil 11:17:48 INFO - building 'psutil._psutil_linux' extension 11:17:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:17:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:17:48 INFO - building 'psutil._psutil_posix' extension 11:17:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:17:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:48 INFO - Successfully installed psutil 11:17:48 INFO - Cleaning up... 11:17:48 INFO - Return code: 0 11:17:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:48 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:17:48 INFO - Using env: {'DISPLAY': ':0', 11:17:48 INFO - 'HOME': '/home/cltbld', 11:17:48 INFO - 'LANG': 'en_US.UTF-8', 11:17:48 INFO - 'LANGUAGE': 'en_US:en', 11:17:48 INFO - 'LOGNAME': 'cltbld', 11:17:48 INFO - 'MAIL': '/var/mail/cltbld', 11:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:48 INFO - 'MOZ_NO_REMOTE': '1', 11:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:48 INFO - 'NO_EM_RESTART': '1', 11:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:48 INFO - 'PWD': '/builds/slave/test', 11:17:48 INFO - 'SHELL': '/bin/bash', 11:17:48 INFO - 'SHLVL': '1', 11:17:48 INFO - 'TERM': 'linux', 11:17:48 INFO - 'TMOUT': '86400', 11:17:48 INFO - 'USER': 'cltbld', 11:17:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:48 INFO - '_': '/tools/buildbot/bin/python'} 11:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:50 INFO - Installing collected packages: mozsystemmonitor 11:17:50 INFO - Running setup.py install for mozsystemmonitor 11:17:50 INFO - Successfully installed mozsystemmonitor 11:17:50 INFO - Cleaning up... 11:17:50 INFO - Return code: 0 11:17:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:17:50 INFO - Using env: {'DISPLAY': ':0', 11:17:50 INFO - 'HOME': '/home/cltbld', 11:17:50 INFO - 'LANG': 'en_US.UTF-8', 11:17:50 INFO - 'LANGUAGE': 'en_US:en', 11:17:50 INFO - 'LOGNAME': 'cltbld', 11:17:50 INFO - 'MAIL': '/var/mail/cltbld', 11:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:50 INFO - 'MOZ_NO_REMOTE': '1', 11:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:50 INFO - 'NO_EM_RESTART': '1', 11:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:50 INFO - 'PWD': '/builds/slave/test', 11:17:50 INFO - 'SHELL': '/bin/bash', 11:17:50 INFO - 'SHLVL': '1', 11:17:50 INFO - 'TERM': 'linux', 11:17:50 INFO - 'TMOUT': '86400', 11:17:50 INFO - 'USER': 'cltbld', 11:17:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:50 INFO - '_': '/tools/buildbot/bin/python'} 11:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:53 INFO - warning: no files found matching '*.txt' 11:17:53 INFO - no previously-included directories found matching 'build' 11:17:53 INFO - no previously-included directories found matching 'dist' 11:17:53 INFO - no previously-included directories found matching '.git*' 11:17:53 INFO - Installing collected packages: jsonschema, functools32 11:17:53 INFO - Running setup.py install for functools32 11:17:53 INFO - warning: no files found matching '*.txt' 11:17:53 INFO - no previously-included directories found matching 'build' 11:17:53 INFO - no previously-included directories found matching 'dist' 11:17:53 INFO - no previously-included directories found matching '.git*' 11:17:53 INFO - Successfully installed jsonschema functools32 11:17:53 INFO - Cleaning up... 11:17:53 INFO - Return code: 0 11:17:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:17:53 INFO - Using env: {'DISPLAY': ':0', 11:17:53 INFO - 'HOME': '/home/cltbld', 11:17:53 INFO - 'LANG': 'en_US.UTF-8', 11:17:53 INFO - 'LANGUAGE': 'en_US:en', 11:17:53 INFO - 'LOGNAME': 'cltbld', 11:17:53 INFO - 'MAIL': '/var/mail/cltbld', 11:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:53 INFO - 'MOZ_NO_REMOTE': '1', 11:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:53 INFO - 'NO_EM_RESTART': '1', 11:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:53 INFO - 'PWD': '/builds/slave/test', 11:17:53 INFO - 'SHELL': '/bin/bash', 11:17:53 INFO - 'SHLVL': '1', 11:17:53 INFO - 'TERM': 'linux', 11:17:53 INFO - 'TMOUT': '86400', 11:17:53 INFO - 'USER': 'cltbld', 11:17:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:53 INFO - '_': '/tools/buildbot/bin/python'} 11:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:53 INFO - Cleaning up... 11:17:53 INFO - Return code: 0 11:17:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:17:53 INFO - Using env: {'DISPLAY': ':0', 11:17:53 INFO - 'HOME': '/home/cltbld', 11:17:53 INFO - 'LANG': 'en_US.UTF-8', 11:17:53 INFO - 'LANGUAGE': 'en_US:en', 11:17:53 INFO - 'LOGNAME': 'cltbld', 11:17:53 INFO - 'MAIL': '/var/mail/cltbld', 11:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:53 INFO - 'MOZ_NO_REMOTE': '1', 11:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:53 INFO - 'NO_EM_RESTART': '1', 11:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:53 INFO - 'PWD': '/builds/slave/test', 11:17:53 INFO - 'SHELL': '/bin/bash', 11:17:53 INFO - 'SHLVL': '1', 11:17:53 INFO - 'TERM': 'linux', 11:17:53 INFO - 'TMOUT': '86400', 11:17:53 INFO - 'USER': 'cltbld', 11:17:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:53 INFO - '_': '/tools/buildbot/bin/python'} 11:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:56 INFO - Downloading docopt-0.6.1.tar.gz 11:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:56 INFO - Running setup.py install for blobuploader 11:17:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:56 INFO - Running setup.py install for requests 11:17:56 INFO - Running setup.py install for docopt 11:17:57 INFO - Successfully installed blobuploader requests docopt 11:17:57 INFO - Cleaning up... 11:17:57 INFO - Return code: 0 11:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:57 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:57 INFO - Using env: {'DISPLAY': ':0', 11:17:57 INFO - 'HOME': '/home/cltbld', 11:17:57 INFO - 'LANG': 'en_US.UTF-8', 11:17:57 INFO - 'LANGUAGE': 'en_US:en', 11:17:57 INFO - 'LOGNAME': 'cltbld', 11:17:57 INFO - 'MAIL': '/var/mail/cltbld', 11:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:57 INFO - 'MOZ_NO_REMOTE': '1', 11:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:57 INFO - 'NO_EM_RESTART': '1', 11:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:57 INFO - 'PWD': '/builds/slave/test', 11:17:57 INFO - 'SHELL': '/bin/bash', 11:17:57 INFO - 'SHLVL': '1', 11:17:57 INFO - 'TERM': 'linux', 11:17:57 INFO - 'TMOUT': '86400', 11:17:57 INFO - 'USER': 'cltbld', 11:17:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:57 INFO - '_': '/tools/buildbot/bin/python'} 11:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:57 INFO - Running setup.py (path:/tmp/pip-tUytQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:57 INFO - Running setup.py (path:/tmp/pip-Rvl6YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:57 INFO - Running setup.py (path:/tmp/pip-Pr1oM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:57 INFO - Running setup.py (path:/tmp/pip-uuWjp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:57 INFO - Running setup.py (path:/tmp/pip-B2eFPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:57 INFO - Running setup.py (path:/tmp/pip-D2lBIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:57 INFO - Running setup.py (path:/tmp/pip-FGksEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:57 INFO - Running setup.py (path:/tmp/pip-YAl5Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:57 INFO - Running setup.py (path:/tmp/pip-TZcdAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:57 INFO - Running setup.py (path:/tmp/pip-CpZfls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:58 INFO - Running setup.py (path:/tmp/pip-MzEg81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:58 INFO - Running setup.py (path:/tmp/pip-XhljIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:58 INFO - Running setup.py (path:/tmp/pip-eHUJMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:58 INFO - Running setup.py (path:/tmp/pip-NoZTDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:58 INFO - Running setup.py (path:/tmp/pip-oHtgWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:58 INFO - Running setup.py (path:/tmp/pip-tt9pvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:58 INFO - Running setup.py (path:/tmp/pip-sUF19q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:58 INFO - Running setup.py install for manifestparser 11:17:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:58 INFO - Running setup.py install for mozcrash 11:17:58 INFO - Running setup.py install for mozdebug 11:17:58 INFO - Running setup.py install for mozdevice 11:17:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:58 INFO - Running setup.py install for mozfile 11:17:59 INFO - Running setup.py install for mozhttpd 11:17:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for mozinfo 11:17:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for mozInstall 11:17:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for mozleak 11:17:59 INFO - Running setup.py install for mozlog 11:17:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for moznetwork 11:17:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for mozprocess 11:17:59 INFO - Running setup.py install for mozprofile 11:17:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:59 INFO - Running setup.py install for mozrunner 11:17:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:00 INFO - Running setup.py install for mozscreenshot 11:18:00 INFO - Running setup.py install for moztest 11:18:00 INFO - Running setup.py install for mozversion 11:18:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:00 INFO - Cleaning up... 11:18:00 INFO - Return code: 0 11:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:00 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:00 INFO - Using env: {'DISPLAY': ':0', 11:18:00 INFO - 'HOME': '/home/cltbld', 11:18:00 INFO - 'LANG': 'en_US.UTF-8', 11:18:00 INFO - 'LANGUAGE': 'en_US:en', 11:18:00 INFO - 'LOGNAME': 'cltbld', 11:18:00 INFO - 'MAIL': '/var/mail/cltbld', 11:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:00 INFO - 'MOZ_NO_REMOTE': '1', 11:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:00 INFO - 'NO_EM_RESTART': '1', 11:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:00 INFO - 'PWD': '/builds/slave/test', 11:18:00 INFO - 'SHELL': '/bin/bash', 11:18:00 INFO - 'SHLVL': '1', 11:18:00 INFO - 'TERM': 'linux', 11:18:00 INFO - 'TMOUT': '86400', 11:18:00 INFO - 'USER': 'cltbld', 11:18:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:00 INFO - '_': '/tools/buildbot/bin/python'} 11:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:00 INFO - Running setup.py (path:/tmp/pip-Sorryz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:00 INFO - Running setup.py (path:/tmp/pip-EjaO6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:00 INFO - Running setup.py (path:/tmp/pip-SIV8Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:00 INFO - Running setup.py (path:/tmp/pip-JRJX1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:00 INFO - Running setup.py (path:/tmp/pip-8IVNOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:00 INFO - Running setup.py (path:/tmp/pip-cDcGwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:00 INFO - Running setup.py (path:/tmp/pip-09Uol1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:01 INFO - Running setup.py (path:/tmp/pip-FIJDy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:01 INFO - Running setup.py (path:/tmp/pip-3TztxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:01 INFO - Running setup.py (path:/tmp/pip-x11q8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:01 INFO - Running setup.py (path:/tmp/pip-T7Mdfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:01 INFO - Running setup.py (path:/tmp/pip-yVxjdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:01 INFO - Running setup.py (path:/tmp/pip-7FD6wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:01 INFO - Running setup.py (path:/tmp/pip-ok6gve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:01 INFO - Running setup.py (path:/tmp/pip-bYH0dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:01 INFO - Running setup.py (path:/tmp/pip-brYdgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:01 INFO - Running setup.py (path:/tmp/pip-7CUQur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:18:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:03 INFO - Downloading blessings-1.6.tar.gz 11:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:03 INFO - Installing collected packages: blessings 11:18:03 INFO - Running setup.py install for blessings 11:18:03 INFO - Successfully installed blessings 11:18:03 INFO - Cleaning up... 11:18:03 INFO - Return code: 0 11:18:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:04 INFO - Reading from file tmpfile_stdout 11:18:04 INFO - Current package versions: 11:18:04 INFO - argparse == 1.2.1 11:18:04 INFO - blessings == 1.6 11:18:04 INFO - blobuploader == 1.2.4 11:18:04 INFO - docopt == 0.6.1 11:18:04 INFO - functools32 == 3.2.3-2 11:18:04 INFO - jsonschema == 2.5.1 11:18:04 INFO - manifestparser == 1.1 11:18:04 INFO - mozInstall == 1.12 11:18:04 INFO - mozcrash == 0.17 11:18:04 INFO - mozdebug == 0.1 11:18:04 INFO - mozdevice == 0.48 11:18:04 INFO - mozfile == 1.2 11:18:04 INFO - mozhttpd == 0.7 11:18:04 INFO - mozinfo == 0.9 11:18:04 INFO - mozleak == 0.1 11:18:04 INFO - mozlog == 3.3 11:18:04 INFO - moznetwork == 0.27 11:18:04 INFO - mozprocess == 0.23 11:18:04 INFO - mozprofile == 0.28 11:18:04 INFO - mozrunner == 6.12 11:18:04 INFO - mozscreenshot == 0.1 11:18:04 INFO - mozsystemmonitor == 0.3 11:18:04 INFO - moztest == 0.7 11:18:04 INFO - mozversion == 1.4 11:18:04 INFO - psutil == 3.1.1 11:18:04 INFO - requests == 1.2.3 11:18:04 INFO - wsgiref == 0.1.2 11:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 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 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:18:04 INFO - Cleaning up... 11:18:04 INFO - Return code: 0 11:18:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcf1b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2349230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:04 INFO - Cleaning up... 11:18:04 INFO - Return code: 0 11:18:04 INFO - Running post-action listener: _resource_record_post_action 11:18:04 INFO - Running post-action listener: _start_resource_monitoring 11:18:04 INFO - Starting resource monitoring. 11:18:04 INFO - [mozharness: 2016-08-19 18:18:04.624295Z] Finished create-virtualenv step (success) 11:18:04 INFO - [mozharness: 2016-08-19 18:18:04.624819Z] Running install step. 11:18:04 INFO - Running pre-action listener: _resource_record_pre_action 11:18:04 INFO - Running main action method: install 11:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:04 INFO - Reading from file tmpfile_stdout 11:18:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:04 INFO - Reading from file tmpfile_stdout 11:18:04 INFO - Output received: 11:18:04 INFO - Usage: mozinstall [options] installer 11:18:04 INFO - Options: 11:18:04 INFO - -h, --help show this help message and exit 11:18:04 INFO - -d DEST, --destination=DEST 11:18:04 INFO - Directory to install application into. [default: 11:18:04 INFO - "/builds/slave/test"] 11:18:04 INFO - --app=APP Application being installed. [default: firefox] 11:18:04 INFO - mkdir: /builds/slave/test/build/application 11:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:18:21 INFO - Reading from file tmpfile_stdout 11:18:21 INFO - Output received: 11:18:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:18:21 INFO - Running post-action listener: _resource_record_post_action 11:18:21 INFO - [mozharness: 2016-08-19 18:18:21.017219Z] Finished install step (success) 11:18:21 INFO - [mozharness: 2016-08-19 18:18:21.017468Z] Running run-tests step. 11:18:21 INFO - Running pre-action listener: _resource_record_pre_action 11:18:21 INFO - Running main action method: run_tests 11:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:21 INFO - Python 2.7.3 11:18:21 INFO - Return code: 0 11:18:21 INFO - grabbing minidump binary from tooltool 11:18: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')]} 11:18: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 0x2343090>, '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 0x23469b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18: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 11:18: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 11:18: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 11:18:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:21 INFO - Return code: 0 11:18:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:18:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:18:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:18:21 INFO - Using env: {'DISPLAY': ':0', 11:18:21 INFO - 'HOME': '/home/cltbld', 11:18:21 INFO - 'LANG': 'en_US.UTF-8', 11:18:21 INFO - 'LANGUAGE': 'en_US:en', 11:18:21 INFO - 'LOGNAME': 'cltbld', 11:18:21 INFO - 'MAIL': '/var/mail/cltbld', 11:18:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:21 INFO - 'MOZ_NO_REMOTE': '1', 11:18:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:21 INFO - 'NO_EM_RESTART': '1', 11:18:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:21 INFO - 'PWD': '/builds/slave/test', 11:18:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:21 INFO - 'SHELL': '/bin/bash', 11:18:21 INFO - 'SHLVL': '1', 11:18:21 INFO - 'TERM': 'linux', 11:18:21 INFO - 'TMOUT': '86400', 11:18:21 INFO - 'USER': 'cltbld', 11:18:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646', 11:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:21 INFO - '_': '/tools/buildbot/bin/python'} 11:18:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:18:21 INFO - mozversion application_buildid: 20160819102824 11:18:21 INFO - mozversion application_changeset: 6b1f62a32be285d0d8956629b2860fb5212bc8de 11:18:21 INFO - mozversion application_display_name: Nightly 11:18:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:21 INFO - mozversion application_name: Firefox 11:18:21 INFO - mozversion application_remotingname: firefox 11:18:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:18:21 INFO - mozversion application_vendor: Mozilla 11:18:21 INFO - mozversion application_version: 51.0a1 11:18:21 INFO - mozversion platform_buildid: 20160819102824 11:18:21 INFO - mozversion platform_changeset: 6b1f62a32be285d0d8956629b2860fb5212bc8de 11:18:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:18:21 INFO - mozversion platform_version: 51.0a1 11:18:21 INFO - using testdate: 1471630701 11:18:21 INFO - actual date: 1471630701 11:18:21 INFO - starting webserver on 'localhost:32905' 11:18:21 INFO - SUITE-START | Running 2 tests 11:18:21 INFO - TEST-START | dromaeo_css 11:18:21 INFO - operating with platform_type : linux_ 11:18:21 INFO - Initialising browser for dromaeo_css test... 11:18:21 INFO - TEST-INFO | started process 8500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKtZiJ2/profile http://localhost:32905/getInfo.html) 11:18:26 INFO - PROCESS | 8500 | __metrics Screen width/height:1600/1200 11:18:26 INFO - PROCESS | 8500 | colorDepth:24 11:18:26 INFO - PROCESS | 8500 | Browser inner width/height: 1024/697 11:18:26 INFO - PROCESS | 8500 | __metrics 11:18:26 ERROR - PROCESS | 8500 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:18:27 INFO - TEST-INFO | 8500: exit 0 11:18:27 INFO - Browser initialized. 11:18:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:27 INFO - TEST-INFO | started process 8618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKtZiJ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:39 INFO - PROCESS | 8618 | RSS: Main: 164384768 11:18:39 INFO - PROCESS | 8618 | 11:19:29 INFO - PROCESS | 8618 | 1471630769305 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:21:41 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32905/tests/dromaeo/cssquery-ext.html) 11:21:43 INFO - PROCESS | 8618 | RSS: Main: 164634624 11:21:43 INFO - PROCESS | 8618 | 11:24:45 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-ext.html (next: http://localhost:32905/tests/dromaeo/cssquery-jquery.html) 11:24:45 INFO - PROCESS | 8618 | RSS: Main: 165412864 11:24:45 INFO - PROCESS | 8618 | 11:27:48 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32905/tests/dromaeo/cssquery-mootools.html) 11:27:48 INFO - PROCESS | 8618 | RSS: Main: 166002688 11:27:48 INFO - PROCESS | 8618 | 11:30:50 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32905/tests/dromaeo/cssquery-prototype.html) 11:30:51 INFO - PROCESS | 8618 | RSS: Main: 163094528 11:30:51 INFO - PROCESS | 8618 | 11:33:54 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32905/tests/dromaeo/cssquery-yui.html) 11:33:54 INFO - PROCESS | 8618 | RSS: Main: 165892096 11:33:54 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:32905/tests/dromaeo/cssquery-yui.html (next: http://localhost:32905/tests/dromaeo/cssquery-dojo.html) 11:36:57 INFO - PROCESS | 8618 | RSS: Main: 167456768 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | __start_tp_report 11:36:57 INFO - PROCESS | 8618 | _x_x_mozilla_page_load 11:36:57 INFO - PROCESS | 8618 | _x_x_mozilla_page_load_details 11:36:57 INFO - PROCESS | 8618 | |i|pagename|runs| 11:36:57 INFO - PROCESS | 8618 | |0;dojo.html;2606.504764094822;2628.9737102628974;2639.195045511118;2640.339915021246;2662.1747258349906;4586.656000799937;4785.66500344976;4789.90420191596;4810.855674329767;4850.781714822832;4730.574248317651;4733.526647335265;4790.137775200471;4815.66290359675;4837.854864354066;4290.334998075287;4471.329300604911;4495.617872480827;4530.116627257669;4534.251848445003;4465.084657645175;4470.82116715331;4516.164509565724;4518.254488009475;4521.751303678297;4212.7472351659;4296.334068219399;4343.413639158704;4367;4396.538363471854;4323.35712429278;4368.781560921973;4385.758783266919;4439.200943830142;4440.844570440019;4380.956190438087;4406.986393129599;4408;4421.535738747418;4446.5331140230455;4699.436067671867;4750.406199225097;4771.188897887333;4815.759212039419;4828.420589529243;5138.563222126124;5153.6392452528335;5154.768035438415;5161.535461808456;5193.506616871391;5038.420581633086;5046.041252162077;5145.536901678829;5202.0896343140175;5205.947940520584;4773.546513081252;4808.230683090689;4812.681986405042;4812.903741925142;4813.518648135194;5214.270002199695;5225.843224703189;5250.264962905197;5256.342957130359;5260.184671375943;4994.500549945049;5018.096742586296;5018.723970181675;5044.344235249468;5054.7978080876355;4970;5032.345795046621;5049.091163590516;5175.404828444702;5188.040212560688;5046.738315421145;5090.669106508065;5096.261042148942;5102.872428189325;5105.183170692671;5097.413797413271;5104.668196567211;5113.795448182031;5114.616403769732;5121.974390128025;4200.285951388271;4214.768187749703;4248.872533823928;4269.423627810206;4298.656107511391;3748.725433352673;3751.1372384351207;3752.9249415011545;3762.7177961652988;3763.682711051165;4360.389545463638;4390.165868485042;4394;4402.977985110054;4406;5071.949280507148;5101.158308879068;5155.716435596003;5214.165733482625;5228.660137091153;4401.625861801719;4415.492218394926;4440.378347031418;4448.844290449819;4461.286194208911;4503.81984720614;4617.445906491243;4625.514320996314;4638.443386793607;4643.558861908114;4799.944012317284;4849.733264670406;4858.076965376567;4860.756962151949;4865.440474345354;5153.665011774223;5164.741762911764;5183.533481986639;5191.480851914778;5205.973970130125;4748.216544270157;4814.253790662453;4847.806087756591;4856.781444835062;4866.124097662455;5086.287919691172;5103.642745007814;5109.77365432301;5117.130087884994;5119.027384797026;5184.118699820964;5187.429382767817;5202.583793296603;5203.583713303003;5215.843524694265;4956.033573453142;5003.199488082035;5006.4242612098615;5040.470750571138;5080.796768129233;4856.611471082376;4899;4915.508449155056;4917.237828136645;4966.354373931365;4861.246506791453;4886.53577910098;4917.852464426073;4919.4834542373965;4938.703677779345;4879.316895634685;4894.094592500399;5039.622028347815;5046.747662616781;5050.444451110448;4818.530348243819;4863.48933362006;4864.756762161807;4880.707157570557;4892 11:36:57 INFO - PROCESS | 8618 | |1;ext.html;532.4462558938704;540.4973374761471;548.761288839355;555.7888002559027;572.2674976030677;34257.31485370294;38180.42729359062;38226.426603600936;38333;38349.61650383502;38252.617473825325;38751.22497550055;38784.61215387845;38825.61174388255;38874.80562597183;7666.846663066722;7767;7797.610119494031;7827.3346765525;7849.136594974549;7449.143348514936;7547.320741133297;7624.275693809107;7628.923710762904;7634.236576342377;7681.078270607535;7693.538387696756;7702.4993375430695;7703.88143260605;7718.073831140243;7583;7621;7633.618319084079;7646.9617651911385;7674.232576742309;7596.9240307596765;7610.961945190294;7618.162002179756;7627.542347459114;7662.1571627120975;35613.643863561294;35928.820355898315;35961.280774384366;35976.46035309473;35990.64009359899;2812.1546139854413;2940.794144409892;3146.937061258785;3280.6719328067243;3767.679747221462;28269.57595636067;28480.145595632162;29364;29436.264093397836;29949.101526954008;3475.4960530722906;3489.7208223342072;3606.8737594184076;3608.368535506302;3671.9632803672157;250619;251195;251925;252305;252518;52841.47158528365;53055.734721326146;53062.734686327094;53255;53261.467385326425;47998.520014799404;53834;54909;55149.44850551523;61406;12236.938815305866;12319.076069294839;12357.814632780515;12387.938060309822;12407.627771166879;9506.47714375716;9570.521473926276;9610.135087842127;9611.423314601147;9625.614975400906;16522.17389130563;16589.6682066358;16653.750193747102;16659.750103748454;16715.749263761052;5993.910091348634;6154.753809847645;6175.876482470415;6177.2587289525545;6243.594166379171;717.8528401677748;800.6917336825364;822.7408366364576;937.4656445825814;1018.2922868606247;25387;27024.86487567589;27037.459250815267;27039;27386.17841464759;786.9567173805381;914.2366124286162;931.4550987672287;948.8007518421209;985.3595163143871;13811.309434528233;14009;14414.351354189086;14518.782218266735;14642.414303427957;372254;373208;373313;375009;377849;48189.518104818504;48290.27564586534;48367.75816120897;48507;48512.757436212596;1115.4032592563103;1125.6960620632547;1128.0918860317522;1146.0888593568134;1171.824226366069;25593.488130237663;26004.73995260099;26614;26694.59958100669;26831.463370732865;41068.383974241005;41374.37938430866;41602.751917442525;41608.58391416168;41644.791776040925;322523;322804;323865;325021;326972;35742.821285893406;35744.463833043046;36192.45711314385;36502;36717;40881.59118408897;41429.1714165709;41493.363052000605;41611.58388416077;41889.79055104705;35113.64886351206;35182.82408587941;35394.29211415809;36158.819205903805;36909.26181476409;35341.29317413689;35808.28383432369;35894.28211435809;35933;36562.26875462529;29760.702392975792;30000.099997000125;30194.2451438707;31502;32444.675553244164;28624.284392890346;30689.232769180948;30788.53817192699;30817.69182308148;31088;23948.760512394652;24088.87955560211;24129.276121716375;24306.27081187567;24369.878150609133 11:36:57 INFO - PROCESS | 8618 | |2;jquery.html;359.4500414366021;368.2248866136782;369.55468660264387;382.54668218161464;387.6162599026964;15263.236838158089;16574;16602.169891505437;16642.833571664294;16732.58168545784;12957;13475.393607287671;13622.659433514142;13977.860221397783;14033.578992630211;4946.134426475362;5231.163013917774;5491.780328786864;5542.944570554303;5608.411116832735;3415.1974286042882;5543.473370029841;5567.7750894803285;5647.830565083054;5904.2324497815225;5898.174255604219;5965.821025369224;5971.4327138921735;5971.522278217754;5975.0439929611275;5876.147958546008;6343.809685709436;6603.834904127411;6662.300458451889;6672.599644021374;6264.5301602380005;6347.079673447324;6421.518386121013;6454;6466.321036291216;18203.45389638313;18315;18375.356862509747;21757.564848703096;23064.654030189562;1969.3402710092137;2019.6465618516702;2099.2337796704246;2118.9046492907855;2358.612721368961;13534.593962181052;14194.219317937612;14222.644433889236;14257.928710356382;15038.924805375904;1794.55136215946;1864.5245462407136;1875.353003213889;1903.0484757621189;1984.3451660951996;64335.678321608095;64838.67580662067;77120.61439692766;77387.22612773857;77677.61161194215;15297.158656273788;15537.68924621524;15606.843931560767;15630.609234768994;15632.843671563367;26968.875913576358;27179.320516987234;27268;27272.181834544994;27735.445291094064;7542.170361260257;7852.882206766903;7856.882146767803;8101.918980810235;8383.329333653293;6313.40022697843;6379.585326953733;6414.518911081687;6451.322611125858;6614.305497922745;7795.532268063935;8053;8055.355571554262;8168.101508834024;8291;1516.8331483536801;1640.516047765912;3329.667033296651;3399.6770306820813;3408.522806807049;762.3139174742776;774.4307933668749;850.7702920211632;863.6631713631689;905.307439808547;15705.528834134995;15725.842741572667;16074.196290185444;16211.918940405458;16421.91789041047;853.5988085599759;854.7093988044095;854.9829003419896;866.5493943149653;900.8290021049371;8989.325800564853;9024.097590241056;9244.445333280024;9369.859452108223;9479.099485548863;272700;274489;277334;379986;384139;82862;84374;85220;85982.14017859867;87910.56044719863;900.6262401103469;911.2664305234217;947.8530827721714;952.3904700991371;955.5556666150273;14836.387532297122;15053.849461505244;15076.623084422978;15189.392424303345;15604.453844115402;25709.742902571485;33707;36859.8160703765;37798.81100594589;39663.603363965995;53502.73248633732;53852.46147538631;54047.72976135094;54442.72778636082;55281.723591381786;7411.5553066816165;7421.517601355895;7474.439417043634;7487.625618719151;7645.350145237495;8644.82710345777;11341.432928353714;11591.594294199662;11740.70648233801;11889.227200232302;9567;9635.373700709431;9874.55564499585;10062.748431289276;10306.12397946183;9174.587143578421;9345.906540934775;9884.950575247078;9994.350367226107;10108.646197383056;9359.438433694;9566.282528810229;9646.228301735704;9708.5145742714;9988.850167247352;7497.250274972459;7522.247775222653;7563.546187228564;7595;7660.80847978805;8091;9774.266929980138;9850;9977.60089596408;10073.496325183858 11:36:57 INFO - PROCESS | 8618 | |3;mootools.html;1359.816424782654;1391.9860801391985;1454.8108745863037;1621.2218135295066;1637.9262933168013;6550.606963582189;6994.915788052847;7149.964250178755;7556.093268807744;7586.696532138715;7269.309415605522;7453.105627324729;7487.7753667389925;7505.4370922180915;7577.734779282726;2139.572085582878;2165.7942495462908;2166.079416248096;2167.869927804329;2168.4578855286177;2104.189886893542;2155.6119898418356;2192.5395666909967;2200.7469141048823;2203.537257175995;2161.3191844568987;2170.565886822642;2171.7936796004433;2174.5433458973635;2192.9561408771815;2092.780258072903;2104.663253879372;2107.515271487551;2107.89460526973;2109.98945005274;2132.115172203534;2173.228503881131;2176.6082105221053;2182.508935489518;2182.5416662500893;7661.310482056641;7679.424043196726;7680.692772289101;7687.231276872324;7688.654010569538;4049.4533238012787;4189.455370801777;4195.811188496525;4196.034911970233;4208.6633069354375;2823.265950852793;2869.856507174654;2928.1508362574828;2954.2614346413397;2963.392504536565;882.5102068352062;917.124146440148;947.5025611553989;951.0822056715303;954.7088138117871;9932.751681207956;10060.647877324333;10132.493375331203;10140.03669651382;10152.644657436955;3945.467361906163;4013.8595149169637;4170.249355116108;4208.494980602347;4214.4310518079665;8687.956560217159;8705;8712.607932643046;8713.738587842376;8733.519656418957;4192.182524407711;4229.6404805591255;4233.555476674905;4253.234417804825;4256.233877901946;3423.8288085595623;3770.5852356240794;3814.6757525610633;3822.617738226211;3865.033741564609;3508.7894726316504;3535.151563624763;3585.3904836177912;3619.5837478690287;3665.321915445651;1140.4012893230954;1171.543098191706;1184.662371224197;1208.6917835951776;1222.3826967381415;794.1859593916282;798.3094623150932;814.9266566009088;823.5964377455124;832.3382910586099;4881.658283920092;4965.478624744422;4977.527134922177;5035.79856805731;5102.55577485196;375.46121315911756;381.4507109761934;388.23130202199803;390.18646122834207;397.598425590156;3436.2096717755057;3448.8448019839166;3454.1709989602314;3469.6877281044826;3555.982220088935;8815.911840881508;9203.263738900872;9253.72238832836;9259.861102083474;9304.209142222851;9168.35821492489;9176.770580735534;9191.31065170115;9196.632134714537;9256.704061431405;6806.319368063154;6889.621070841152;6977.686004129725;6995.230524642286;7001.649917504104;4907.263910413324;4910.631702622246;5014.799408023784;5024.045431368175;5177.430482646831;8342.416030877781;8355.373346998878;8375.078741338326;8407.411481196257;8483.872741909;8434.746957591282;8653.69712060075;8656.91343086561;8684.305255579664;8734.213920747163;6174.44430001302;6238.376162383725;6240.843978900564;6292.2134733158355;6400.295967443484;7221.819454513679;7270.781876543712;7271.527350722186;7273.599952002691;7285;6075.119107729266;6080.543959202989;6333.524985626004;6334.113224148531;6430.356964303533;6435.002574600944;6475.449586784987;6568.868622627425;6571.507136964842;6596.67016649156;5681.630694004876;5751.396103409082;5784.681842498703;5809.680467574324;5815.098659707752;4374.015846434527;4408.470983482002;4413.646908247397;4455.903147312587;4569.977150114228;4298.978505107454;4384;4403.757793321398;4415.359772832985;4469 11:36:57 INFO - PROCESS | 8618 | |4;prototype.html;290.38728283322195;299.9790014698972;301.6892600621358;301.71487943893004;304.77751241593637;5034.924476132856;5036.5718913892315;5067.873303167423;5072.13773658478;5082.644214904958;4927.8912244744915;4942.209246520558;4957.950420495794;4994.42564105128;5003.699778013312;3686.3364594372933;3818.8472461101524;3887.2614203301423;3903.7657740535515;3908.7263891527605;3893.493845800042;3896.688264938812;3906.863259785908;3917.3536366499634;3919.764814111148;3877.612238776114;3890.8832735017854;3894.4547763313158;3906.9413958790497;3916.373380259159;3825.5026846509777;3875.779129574175;3888;3938.5273767147983;3942.1327307992196;3431.553897993245;3433.4506478963244;3433.6223015468277;3440.6559344065645;3467.3932061889323;4835.500994691622;4851.223804191312;4851.248056551241;4880.658353915227;4924.926126108111;4412;4451.955480445186;4472.955270447286;4487.640988720927;4504.234280172379;5170.638055336128;5193.143131383317;5203.453637368059;5205.24523944026;5214.983078299733;3764.7176461765475;3765.3410653135593;3768.2840260350445;3793.6775374093236;3798.582155962842;5450.4549545045575;5510.779568817243;5517;5528.838943821802;5542.057850165482;3540.5751309842985;3743.1765011697385;3762.473253744478;3773.9245215095543;3777.4522694209186;3828.444875493038;3828.636279553438;3833.884983450501;3835.4246862970776;3848.9230215395537;4423.270160423494;4424.247877860771;4427.22523558376;4439.223135951195;4441.067375851043;5099.107656160157;5204.947950520446;5208.427073021964;5253.080710875658;5282.81510147143;1307.6142537951328;1309.9148555343872;1317.9653971632222;1320.2836312793331;1320.656629276395;809.9797505062421;827.1397746343736;830.3979614779237;842.751388340441;844.9112843151504;4340.782960851945;4441.178381999341;4565;4580.648708630962;4592.448906131285;5410.431904649955;5421.701806400607;5423.637344846221;5432.130859062531;5438;4583.312503124492;4606.891870308282;4615.9076818463445;4618.214903466419;4639.675222734444;2730.3993121513236;2866.613007244037;2876.6979467156066;2885.5383138697707;2892.9026455819785;5118.462561431071;5128.25640282157;5130.410002849645;5130.615203859726;5165.173572228426;5312.681239125664;5515.580340189108;5553.140132831595;5561.4716601923565;5584.888302233932;5075.974620126875;5082.2122571001555;5100.872478188001;5114.641975061784;5116.872078198075;5396.271503346998;5423.864403389789;5453.427390124139;5463.125899856004;5472.261244731911;5074.517920797518;5307.389650190123;5310.336207974004;5345;5364.946350536445;5102.79588816458;5113.693178409308;5182.274481572658;5182.300389447527;5209;3903.219356128729;3921.8039098045556;3962.5641179470813;3962.7622342659533;3963.8810835674976;5091.898162036812;5392.274472168869;5421.593380496557;5481.424450432806;5498.45015498447;5249;5257.342832145981;5283.181106928432;5286.656367336111;5291.962594401106;5282.8943421132135;5290.936534751527;5310.539601609588;5330.360356757214;5339.652922560022;5084.2881996521255;5127.717975511383;5162.8967420652125;5166;5175.870603234949;4994.750262486788;5159.767810448614;5273.578113750814;5298.97350513245;5310.097283461898;5163.922541161811;5191.74041297926;5205.843824685266;5207.479252074762;5220.3213582235585 11:36:57 INFO - PROCESS | 8618 | |5;yui.html;633.4140919649325;734.823642325842;739.2459691115059;741.8367959049011;747.7943565519481;12013.219140755855;13031.934840325785;13149;13173.473061077557;13236.470541178342;12078.335691536962;13306;13471.393787279596;13472.932635336809;13515.932420337884;749.5015814483376;766.9846603067936;768.4083255892959;770.0182267608816;771.4368510986955;629.4649547884308;755.4221020919001;776.7397921696239;783.3967844759532;784.9921500785005;819.1276290750361;820.5199958024563;821.3059964330131;822.6585966823761;823.1110400767187;808.462372522272;814.5927036481759;815.9347252219808;816.1797393619433;817.0971076959933;593.7773334999375;593.8485686150048;594.0198672190919;594.5362617158623;595.8242318516048;13076.934615326958;13088.869111308955;13145.737085258337;13152;13161.802572961413;13470.326483675875;13610.319484025758;13634.181949083088;13681.794773078413;14141.151530908179;10459.11097556701;10625.946870265676;10662.306950048222;10723.410212438313;10889.183311251687;3265.5428240046413;3298.307355455357;3301.60380754311;3302.6862448067395;3303.504474328846;61435.69282153605;63811.680941595456;64634;65340.3465965339;65596.3440365595;10526.631567895087;10678.893211067945;10809.135269178447;10814.405207713495;10886;20145.597088058155;20148.19407223724;20218;20233.696494552594;20543.4864128398;7118.857622847514;7175.17485489165;7213.495055346076;7234.891476627855;7314.45141614381;3638.945415818712;3807.200487897517;3813.593083940903;3829.425586162098;3854.209886973164;2771.80597358183;2882.2506148401567;2899.869505872241;2907.2295841601995;2908.9818563502604;469.3616681313411;482.81411656512495;482.876866399066;483.3957553058677;494.9653524253268;522.1176212201367;536.9570434365241;547.2284079447959;550.2599004339157;551.9641223320472;7522.548647081193;7762.611869406507;7789;7952.562609056442;8201.42663891261;463.84895732885815;492.7683988525387;566.9971650141723;571.0549041336594;621.1828315004274;3538.752287339913;3570.3751843427817;3661.23114146027;3727;3737.1965027519213;73073.63463182756;74849.25150748531;93109;93219;94067.52966235262;73256;75175;76395.61802190954;77172.61413692895;79994;46341.53658463372;68665.65667171632;70170.98290170942;72991.63504182445;74319.25680743232;7870.9606451967375;8615.396922215636;8633.30933525329;8675.262602678842;8713.869291960753;42168.36747448852;42374.788126059175;43365.783171085204;43775.56224437842;45341.319880202485;33979.830100849336;34817.825910870284;39020.60979390283;60266.69866650639;62486.68756656188;10522.421266830397;10541.31481453703;10780.784384312114;10830.891691082988;11441.313521188755;12845.357732113544;12994.35028248565;13087.934560327138;13406.061575689608;14036.719265614835;10862;10872.293300935415;11264.887351126385;11429.257098288585;11954.701132471759;11498.597549085742;11634.418279085843;11668.066554675775;11670;12338.876611233773;10728.746963137517;10829.945850270698;10980.341179529254;11161.944190279322;11693.473793679135;10324.948375258076;10376.740581485523;10741.516631751434;10804.24370294072;10938.890611093788;9997.200223982209;10166.796664066826;10167;10214.131798797185;10234.130098941674 11:36:57 INFO - PROCESS | 8618 | __end_tp_report 11:36:57 INFO - PROCESS | 8618 | __start_cc_report 11:36:57 INFO - PROCESS | 8618 | _x_x_mozilla_cycle_collect,357 11:36:57 INFO - PROCESS | 8618 | __end_cc_report 11:36:57 INFO - PROCESS | 8618 | __startTimestamp1471631817782__endTimestamp 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | ------- Summary: start ------- 11:36:57 INFO - PROCESS | 8618 | Number of tests: 6 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#0] dojo.html Cycles:165 Average:4730.65 Median:4856.78 stddev:507.69 (10.5%) stddev-sans-first:481.12 11:36:57 INFO - PROCESS | 8618 | Values: 2606.5 2629.0 2639.2 2640.3 2662.2 4586.7 4785.7 4789.9 4810.9 4850.8 4730.6 4733.5 4790.1 4815.7 4837.9 4290.3 4471.3 4495.6 4530.1 4534.3 4465.1 4470.8 4516.2 4518.3 4521.8 4212.7 4296.3 4343.4 4367.0 4396.5 4323.4 4368.8 4385.8 4439.2 4440.8 4381.0 4407.0 4408.0 4421.5 4446.5 4699.4 4750.4 4771.2 4815.8 4828.4 5138.6 5153.6 5154.8 5161.5 5193.5 5038.4 5046.0 5145.5 5202.1 5205.9 4773.5 4808.2 4812.7 4812.9 4813.5 5214.3 5225.8 5250.3 5256.3 5260.2 4994.5 5018.1 5018.7 5044.3 5054.8 4970.0 5032.3 5049.1 5175.4 5188.0 5046.7 5090.7 5096.3 5102.9 5105.2 5097.4 5104.7 5113.8 5114.6 5122.0 4200.3 4214.8 4248.9 4269.4 4298.7 3748.7 3751.1 3752.9 3762.7 3763.7 4360.4 4390.2 4394.0 4403.0 4406.0 5071.9 5101.2 5155.7 5214.2 5228.7 4401.6 4415.5 4440.4 4448.8 4461.3 4503.8 4617.4 4625.5 4638.4 4643.6 4799.9 4849.7 4858.1 4860.8 4865.4 5153.7 5164.7 5183.5 5191.5 5206.0 4748.2 4814.3 4847.8 4856.8 4866.1 5086.3 5103.6 5109.8 5117.1 5119.0 5184.1 5187.4 5202.6 5203.6 5215.8 4956.0 5003.2 5006.4 5040.5 5080.8 4856.6 4899.0 4915.5 4917.2 4966.4 4861.2 4886.5 4917.9 4919.5 4938.7 4879.3 4894.1 5039.6 5046.7 5050.4 4818.5 4863.5 4864.8 4880.7 4892.0 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#1] ext.html Cycles:180 Average:46786.53 Median:204581.63 stddev:84444.44 (41.3%) stddev-sans-first:84609.91 11:36:57 INFO - PROCESS | 8618 | Values: 532.4 540.5 548.8 555.8 572.3 34257.3 38180.4 38226.4 38333.0 38349.6 38252.6 38751.2 38784.6 38825.6 38874.8 7666.8 7767.0 7797.6 7827.3 7849.1 7449.1 7547.3 7624.3 7628.9 7634.2 7681.1 7693.5 7702.5 7703.9 7718.1 7583.0 7621.0 7633.6 7647.0 7674.2 7596.9 7611.0 7618.2 7627.5 7662.2 35613.6 35928.8 35961.3 35976.5 35990.6 2812.2 2940.8 3146.9 3280.7 3767.7 28269.6 28480.1 29364.0 29436.3 29949.1 3475.5 3489.7 3606.9 3608.4 3672.0 250619.0 251195.0 251925.0 252305.0 252518.0 52841.5 53055.7 53062.7 53255.0 53261.5 47998.5 53834.0 54909.0 55149.4 61406.0 12236.9 12319.1 12357.8 12387.9 12407.6 9506.5 9570.5 9610.1 9611.4 9625.6 16522.2 16589.7 16653.8 16659.8 16715.7 5993.9 6154.8 6175.9 6177.3 6243.6 717.9 800.7 822.7 937.5 1018.3 25387.0 27024.9 27037.5 27039.0 27386.2 787.0 914.2 931.5 948.8 985.4 13811.3 14009.0 14414.4 14518.8 14642.4 372254.0 373208.0 373313.0 375009.0 377849.0 48189.5 48290.3 48367.8 48507.0 48512.8 1115.4 1125.7 1128.1 1146.1 1171.8 25593.5 26004.7 26614.0 26694.6 26831.5 41068.4 41374.4 41602.8 41608.6 41644.8 322523.0 322804.0 323865.0 325021.0 326972.0 35742.8 35744.5 36192.5 36502.0 36717.0 40881.6 41429.2 41493.4 41611.6 41889.8 35113.6 35182.8 35394.3 36158.8 36909.3 35341.3 35808.3 35894.3 35933.0 36562.3 29760.7 30000.1 30194.2 31502.0 32444.7 28624.3 30689.2 30788.5 30817.7 31088.0 23948.8 24088.9 24129.3 24306.3 24369.9 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#2] jquery.html Cycles:180 Average:23278.07 Median:5628.12 stddev:54030.28 (960.0%) stddev-sans-first:54154.45 11:36:57 INFO - PROCESS | 8618 | Values: 359.5 368.2 369.6 382.5 387.6 15263.2 16574.0 16602.2 16642.8 16732.6 12957.0 13475.4 13622.7 13977.9 14033.6 4946.1 5231.2 5491.8 5542.9 5608.4 3415.2 5543.5 5567.8 5647.8 5904.2 5898.2 5965.8 5971.4 5971.5 5975.0 5876.1 6343.8 6603.8 6662.3 6672.6 6264.5 6347.1 6421.5 6454.0 6466.3 18203.5 18315.0 18375.4 21757.6 23064.7 1969.3 2019.6 2099.2 2118.9 2358.6 13534.6 14194.2 14222.6 14257.9 15038.9 1794.6 1864.5 1875.4 1903.0 1984.3 64335.7 64838.7 77120.6 77387.2 77677.6 15297.2 15537.7 15606.8 15630.6 15632.8 26968.9 27179.3 27268.0 27272.2 27735.4 7542.2 7852.9 7856.9 8101.9 8383.3 6313.4 6379.6 6414.5 6451.3 6614.3 7795.5 8053.0 8055.4 8168.1 8291.0 1516.8 1640.5 3329.7 3399.7 3408.5 762.3 774.4 850.8 863.7 905.3 15705.5 15725.8 16074.2 16211.9 16421.9 853.6 854.7 855.0 866.5 900.8 8989.3 9024.1 9244.4 9369.9 9479.1 272700.0 274489.0 277334.0 379986.0 384139.0 82862.0 84374.0 85220.0 85982.1 87910.6 900.6 911.3 947.9 952.4 955.6 14836.4 15053.8 15076.6 15189.4 15604.5 25709.7 33707.0 36859.8 37798.8 39663.6 53502.7 53852.5 54047.7 54442.7 55281.7 7411.6 7421.5 7474.4 7487.6 7645.4 8644.8 11341.4 11591.6 11740.7 11889.2 9567.0 9635.4 9874.6 10062.7 10306.1 9174.6 9345.9 9885.0 9994.4 10108.6 9359.4 9566.3 9646.2 9708.5 9988.9 7497.3 7522.2 7563.5 7595.0 7660.8 8091.0 9774.3 9850.0 9977.6 10073.5 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#3] mootools.html Cycles:180 Average:4893.05 Median:4908.95 stddev:2735.33 (55.7%) stddev-sans-first:2730.11 11:36:57 INFO - PROCESS | 8618 | Values: 1359.8 1392.0 1454.8 1621.2 1637.9 6550.6 6994.9 7150.0 7556.1 7586.7 7269.3 7453.1 7487.8 7505.4 7577.7 2139.6 2165.8 2166.1 2167.9 2168.5 2104.2 2155.6 2192.5 2200.7 2203.5 2161.3 2170.6 2171.8 2174.5 2193.0 2092.8 2104.7 2107.5 2107.9 2110.0 2132.1 2173.2 2176.6 2182.5 2182.5 7661.3 7679.4 7680.7 7687.2 7688.7 4049.5 4189.5 4195.8 4196.0 4208.7 2823.3 2869.9 2928.2 2954.3 2963.4 882.5 917.1 947.5 951.1 954.7 9932.8 10060.6 10132.5 10140.0 10152.6 3945.5 4013.9 4170.2 4208.5 4214.4 8688.0 8705.0 8712.6 8713.7 8733.5 4192.2 4229.6 4233.6 4253.2 4256.2 3423.8 3770.6 3814.7 3822.6 3865.0 3508.8 3535.2 3585.4 3619.6 3665.3 1140.4 1171.5 1184.7 1208.7 1222.4 794.2 798.3 814.9 823.6 832.3 4881.7 4965.5 4977.5 5035.8 5102.6 375.5 381.5 388.2 390.2 397.6 3436.2 3448.8 3454.2 3469.7 3556.0 8815.9 9203.3 9253.7 9259.9 9304.2 9168.4 9176.8 9191.3 9196.6 9256.7 6806.3 6889.6 6977.7 6995.2 7001.6 4907.3 4910.6 5014.8 5024.0 5177.4 8342.4 8355.4 8375.1 8407.4 8483.9 8434.7 8653.7 8656.9 8684.3 8734.2 6174.4 6238.4 6240.8 6292.2 6400.3 7221.8 7270.8 7271.5 7273.6 7285.0 6075.1 6080.5 6333.5 6334.1 6430.4 6435.0 6475.4 6568.9 6571.5 6596.7 5681.6 5751.4 5784.7 5809.7 5815.1 4374.0 4408.5 4413.6 4455.9 4570.0 4299.0 4384.0 4403.8 4415.4 4469.0 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#4] prototype.html Cycles:180 Average:4359.16 Median:5019.31 stddev:1278.89 (25.5%) stddev-sans-first:1245.48 11:36:57 INFO - PROCESS | 8618 | Values: 290.4 300.0 301.7 301.7 304.8 5034.9 5036.6 5067.9 5072.1 5082.6 4927.9 4942.2 4958.0 4994.4 5003.7 3686.3 3818.8 3887.3 3903.8 3908.7 3893.5 3896.7 3906.9 3917.4 3919.8 3877.6 3890.9 3894.5 3906.9 3916.4 3825.5 3875.8 3888.0 3938.5 3942.1 3431.6 3433.5 3433.6 3440.7 3467.4 4835.5 4851.2 4851.2 4880.7 4924.9 4412.0 4452.0 4473.0 4487.6 4504.2 5170.6 5193.1 5203.5 5205.2 5215.0 3764.7 3765.3 3768.3 3793.7 3798.6 5450.5 5510.8 5517.0 5528.8 5542.1 3540.6 3743.2 3762.5 3773.9 3777.5 3828.4 3828.6 3833.9 3835.4 3848.9 4423.3 4424.2 4427.2 4439.2 4441.1 5099.1 5204.9 5208.4 5253.1 5282.8 1307.6 1309.9 1318.0 1320.3 1320.7 810.0 827.1 830.4 842.8 844.9 4340.8 4441.2 4565.0 4580.6 4592.4 5410.4 5421.7 5423.6 5432.1 5438.0 4583.3 4606.9 4615.9 4618.2 4639.7 2730.4 2866.6 2876.7 2885.5 2892.9 5118.5 5128.3 5130.4 5130.6 5165.2 5312.7 5515.6 5553.1 5561.5 5584.9 5076.0 5082.2 5100.9 5114.6 5116.9 5396.3 5423.9 5453.4 5463.1 5472.3 5074.5 5307.4 5310.3 5345.0 5364.9 5102.8 5113.7 5182.3 5182.3 5209.0 3903.2 3921.8 3962.6 3962.8 3963.9 5091.9 5392.3 5421.6 5481.4 5498.5 5249.0 5257.3 5283.2 5286.7 5292.0 5282.9 5290.9 5310.5 5330.4 5339.7 5084.3 5127.7 5162.9 5166.0 5175.9 4994.8 5159.8 5273.6 5299.0 5310.1 5163.9 5191.7 5205.8 5207.5 5220.3 11:36:57 INFO - PROCESS | 8618 | 11:36:57 INFO - PROCESS | 8618 | [#5] yui.html Cycles:180 Average:16639.93 Median:21437.41 stddev:22792.15 (106.3%) stddev-sans-first:22824.39 11:36:57 INFO - PROCESS | 8618 | Values: 633.4 734.8 739.2 741.8 747.8 12013.2 13031.9 13149.0 13173.5 13236.5 12078.3 13306.0 13471.4 13472.9 13515.9 749.5 767.0 768.4 770.0 771.4 629.5 755.4 776.7 783.4 785.0 819.1 820.5 821.3 822.7 823.1 808.5 814.6 815.9 816.2 817.1 593.8 593.8 594.0 594.5 595.8 13076.9 13088.9 13145.7 13152.0 13161.8 13470.3 13610.3 13634.2 13681.8 14141.2 10459.1 10625.9 10662.3 10723.4 10889.2 3265.5 3298.3 3301.6 3302.7 3303.5 61435.7 63811.7 64634.0 65340.3 65596.3 10526.6 10678.9 10809.1 10814.4 10886.0 20145.6 20148.2 20218.0 20233.7 20543.5 7118.9 7175.2 7213.5 7234.9 7314.5 3638.9 3807.2 3813.6 3829.4 3854.2 2771.8 2882.3 2899.9 2907.2 2909.0 469.4 482.8 482.9 483.4 495.0 522.1 537.0 547.2 550.3 552.0 7522.5 7762.6 7789.0 7952.6 8201.4 463.8 492.8 567.0 571.1 621.2 3538.8 3570.4 3661.2 3727.0 3737.2 73073.6 74849.3 93109.0 93219.0 94067.5 73256.0 75175.0 76395.6 77172.6 79994.0 46341.5 68665.7 70171.0 72991.6 74319.3 7871.0 8615.4 8633.3 8675.3 8713.9 42168.4 42374.8 43365.8 43775.6 45341.3 33979.8 34817.8 39020.6 60266.7 62486.7 10522.4 10541.3 10780.8 10830.9 11441.3 12845.4 12994.4 13087.9 13406.1 14036.7 10862.0 10872.3 11264.9 11429.3 11954.7 11498.6 11634.4 11668.1 11670.0 12338.9 10728.7 10829.9 10980.3 11161.9 11693.5 10324.9 10376.7 10741.5 10804.2 10938.9 9997.2 10166.8 10167.0 10214.1 10234.1 11:36:57 INFO - PROCESS | 8618 | -------- Summary: end -------- 11:36:57 INFO - PROCESS | 8618 | 11:36:58 INFO - TEST-INFO | 8618: exit 0 11:36:58 INFO - TEST-OK | dromaeo_css | took 1117270ms 11:36:58 INFO - TEST-START | kraken 11:36:58 INFO - operating with platform_type : linux_ 11:36:58 INFO - Initialising browser for kraken test... 11:36:58 INFO - TEST-INFO | started process 8970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn2HkFC/profile http://localhost:32905/getInfo.html) 11:37:03 INFO - PROCESS | 8970 | __metrics Screen width/height:1600/1200 11:37:03 INFO - PROCESS | 8970 | colorDepth:24 11:37:03 INFO - PROCESS | 8970 | Browser inner width/height: 1024/697 11:37:03 INFO - PROCESS | 8970 | __metrics 11:37:03 ERROR - PROCESS | 8970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:37:04 INFO - TEST-INFO | 8970: exit 0 11:37:04 INFO - Browser initialized. 11:37:04 INFO - Running cycle 1/1 for kraken test... 11:37:04 INFO - TEST-INFO | started process 9092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn2HkFC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:16 INFO - PROCESS | 9092 | RSS: Main: 164298752 11:37:16 INFO - PROCESS | 9092 | 11:37:19 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32905/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:20 INFO - PROCESS | 9092 | RSS: Main: 169451520 11:37:20 INFO - PROCESS | 9092 | 11:37:23 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32905/tests/kraken/driver.html?testName=audio-dft) 11:37:23 INFO - PROCESS | 9092 | RSS: Main: 168140800 11:37:23 INFO - PROCESS | 9092 | 11:37:26 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32905/tests/kraken/driver.html?testName=audio-fft) 11:37:27 INFO - PROCESS | 9092 | RSS: Main: 164540416 11:37:27 INFO - PROCESS | 9092 | 11:37:29 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32905/tests/kraken/driver.html?testName=audio-oscillator) 11:37:30 INFO - PROCESS | 9092 | RSS: Main: 165302272 11:37:30 INFO - PROCESS | 9092 | 11:37:32 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:33 INFO - PROCESS | 9092 | RSS: Main: 165396480 11:37:33 INFO - PROCESS | 9092 | 11:37:36 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32905/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:37 INFO - PROCESS | 9092 | RSS: Main: 165675008 11:37:37 INFO - PROCESS | 9092 | 11:37:40 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32905/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:41 INFO - PROCESS | 9092 | RSS: Main: 163037184 11:37:41 INFO - PROCESS | 9092 | 11:37:44 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32905/tests/kraken/driver.html?testName=json-parse-financial) 11:37:45 INFO - PROCESS | 9092 | RSS: Main: 165081088 11:37:45 INFO - PROCESS | 9092 | 11:37:46 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:47 INFO - PROCESS | 9092 | RSS: Main: 165081088 11:37:47 INFO - PROCESS | 9092 | 11:37:49 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:49 INFO - PROCESS | 9092 | RSS: Main: 165289984 11:37:49 INFO - PROCESS | 9092 | 11:37:52 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:52 INFO - PROCESS | 9092 | RSS: Main: 165576704 11:37:52 INFO - PROCESS | 9092 | 11:37:55 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:56 INFO - PROCESS | 9092 | RSS: Main: 166047744 11:37:56 INFO - PROCESS | 9092 | 11:37:59 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:00 INFO - PROCESS | 9092 | RSS: Main: 166187008 11:38:00 INFO - PROCESS | 9092 | 11:38:01 INFO - PROCESS | 9092 | Cycle 1(1): loaded http://localhost:32905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32905/tests/kraken/driver.html?testName=ai-astar) 11:38:02 INFO - PROCESS | 9092 | RSS: Main: 166625280 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | __start_tp_report 11:38:02 INFO - PROCESS | 9092 | _x_x_mozilla_page_load 11:38:02 INFO - PROCESS | 9092 | _x_x_mozilla_page_load_details 11:38:02 INFO - PROCESS | 9092 | |i|pagename|runs| 11:38:02 INFO - PROCESS | 9092 | |0;ai-astar;110;119;115;115;117;117;121;116;116;115 11:38:02 INFO - PROCESS | 9092 | |1;audio-beat-detection;152;123;146;180;127;148;159;123;197;130 11:38:02 INFO - PROCESS | 9092 | |2;audio-dft;172;167;166;170;164;165;163;164;164;166 11:38:02 INFO - PROCESS | 9092 | |3;audio-fft;77;77;76;180;77;75;85;76;160;77 11:38:02 INFO - PROCESS | 9092 | |4;audio-oscillator;87;88;154;87;88;88;147;87;87;137 11:38:02 INFO - PROCESS | 9092 | |5;imaging-gaussian-blur;118;118;118;118;119;121;117;118;119;119 11:38:02 INFO - PROCESS | 9092 | |6;imaging-darkroom;152;151;147;148;152;148;150;152;148;148 11:38:02 INFO - PROCESS | 9092 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;95;96 11:38:02 INFO - PROCESS | 9092 | |8;json-parse-financial;65;65;66;65;65;65;66;66;63;64 11:38:02 INFO - PROCESS | 9092 | |9;json-stringify-tinderbox;68;67;66;68;67;66;68;66;67;66 11:38:02 INFO - PROCESS | 9092 | |10;stanford-crypto-aes;88;85;83;86;86;90;88;89;88;84 11:38:02 INFO - PROCESS | 9092 | |11;stanford-crypto-ccm;137;135;143;139;136;140;145;157;162;148 11:38:02 INFO - PROCESS | 9092 | |12;stanford-crypto-pbkdf2;182;174;174;176;184;173;180;190;177;178 11:38:02 INFO - PROCESS | 9092 | |13;stanford-crypto-sha256-iterative;72;71;75;77;72;70;71;71;69;68 11:38:02 INFO - PROCESS | 9092 | __end_tp_report 11:38:02 INFO - PROCESS | 9092 | __start_cc_report 11:38:02 INFO - PROCESS | 9092 | _x_x_mozilla_cycle_collect,964 11:38:02 INFO - PROCESS | 9092 | __end_cc_report 11:38:02 INFO - PROCESS | 9092 | __startTimestamp1471631882166__endTimestamp 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | ------- Summary: start ------- 11:38:02 INFO - PROCESS | 9092 | Number of tests: 14 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#0] ai-astar Cycles:10 Average:116.10 Median:116.50 stddev:2.88 (2.5%) stddev-sans-first:2.05 11:38:02 INFO - PROCESS | 9092 | Values: 110.0 119.0 115.0 115.0 117.0 117.0 121.0 116.0 116.0 115.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:150.00 stddev:24.90 (16.6%) stddev-sans-first:26.37 11:38:02 INFO - PROCESS | 9092 | Values: 152.0 123.0 146.0 180.0 127.0 148.0 159.0 123.0 197.0 130.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:2.88 (1.7%) stddev-sans-first:2.13 11:38:02 INFO - PROCESS | 9092 | Values: 172.0 167.0 166.0 170.0 164.0 165.0 163.0 164.0 164.0 166.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.00 stddev:39.38 (51.1%) stddev-sans-first:41.17 11:38:02 INFO - PROCESS | 9092 | Values: 77.0 77.0 76.0 180.0 77.0 75.0 85.0 76.0 160.0 77.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:87.00 stddev:28.58 (32.9%) stddev-sans-first:29.56 11:38:02 INFO - PROCESS | 9092 | Values: 87.0 88.0 154.0 87.0 88.0 88.0 147.0 87.0 87.0 137.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 11:38:02 INFO - PROCESS | 9092 | Values: 118.0 118.0 118.0 118.0 119.0 121.0 117.0 118.0 119.0 119.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.50 stddev:2.01 (1.3%) stddev-sans-first:1.94 11:38:02 INFO - PROCESS | 9092 | Values: 152.0 151.0 147.0 148.0 152.0 148.0 150.0 152.0 148.0 148.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:38:02 INFO - PROCESS | 9092 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 11:38:02 INFO - PROCESS | 9092 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 63.0 64.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 11:38:02 INFO - PROCESS | 9092 | Values: 68.0 67.0 66.0 68.0 67.0 66.0 68.0 66.0 67.0 66.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:88.00 stddev:2.26 (2.6%) stddev-sans-first:2.35 11:38:02 INFO - PROCESS | 9092 | Values: 88.0 85.0 83.0 86.0 86.0 90.0 88.0 89.0 88.0 84.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:144.00 stddev:9.10 (6.3%) stddev-sans-first:9.27 11:38:02 INFO - PROCESS | 9092 | Values: 137.0 135.0 143.0 139.0 136.0 140.0 145.0 157.0 162.0 148.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.00 stddev:5.33 (3.0%) stddev-sans-first:5.53 11:38:02 INFO - PROCESS | 9092 | Values: 182.0 174.0 174.0 176.0 184.0 173.0 180.0 190.0 177.0 178.0 11:38:02 INFO - PROCESS | 9092 | 11:38:02 INFO - PROCESS | 9092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:2.67 (3.7%) stddev-sans-first:2.83 11:38:02 INFO - PROCESS | 9092 | Values: 72.0 71.0 75.0 77.0 72.0 70.0 71.0 71.0 69.0 68.0 11:38:02 INFO - PROCESS | 9092 | -------- Summary: end -------- 11:38:02 INFO - PROCESS | 9092 | 11:38:03 INFO - TEST-INFO | 9092: exit 0 11:38:03 INFO - TEST-OK | kraken | took 64929ms 11:38:03 INFO - SUITE-END | took 1182s 11:38:03 INFO - Completed test suite (00:19:42) 11:38:03 INFO - javascript benchmark 11:38:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6414.119186263893, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.504764094822, 2628.9737102628974, 2639.195045511118, 2640.339915021246, 2662.1747258349906, 4586.656000799937, 4785.66500344976, 4789.90420191596, 4810.855674329767, 4850.781714822832, 4730.574248317651, 4733.526647335265, 4790.137775200471, 4815.66290359675, 4837.854864354066, 4290.334998075287, 4471.329300604911, 4495.617872480827, 4530.116627257669, 4534.251848445003, 4465.084657645175, 4470.82116715331, 4516.164509565724, 4518.254488009475, 4521.751303678297, 4212.7472351659, 4296.334068219399, 4343.413639158704, 4367.0, 4396.538363471854, 4323.35712429278, 4368.781560921973, 4385.758783266919, 4439.200943830142, 4440.844570440019, 4380.956190438087, 4406.986393129599, 4408.0, 4421.535738747418, 4446.5331140230455, 4699.436067671867, 4750.406199225097, 4771.188897887333, 4815.759212039419, 4828.420589529243, 5138.563222126124, 5153.6392452528335, 5154.768035438415, 5161.535461808456, 5193.506616871391, 5038.420581633086, 5046.041252162077, 5145.536901678829, 5202.0896343140175, 5205.947940520584, 4773.546513081252, 4808.230683090689, 4812.681986405042, 4812.903741925142, 4813.518648135194, 5214.270002199695, 5225.843224703189, 5250.264962905197, 5256.342957130359, 5260.184671375943, 4994.500549945049, 5018.096742586296, 5018.723970181675, 5044.344235249468, 5054.7978080876355, 4970.0, 5032.345795046621, 5049.091163590516, 5175.404828444702, 5188.040212560688, 5046.738315421145, 5090.669106508065, 5096.261042148942, 5102.872428189325, 5105.183170692671, 5097.413797413271, 5104.668196567211, 5113.795448182031, 5114.616403769732, 5121.974390128025, 4200.285951388271, 4214.768187749703, 4248.872533823928, 4269.423627810206, 4298.656107511391, 3748.725433352673, 3751.1372384351207, 3752.9249415011545, 3762.7177961652988, 3763.682711051165, 4360.389545463638, 4390.165868485042, 4394.0, 4402.977985110054, 4406.0, 5071.949280507148, 5101.158308879068, 5155.716435596003, 5214.165733482625, 5228.660137091153, 4401.625861801719, 4415.492218394926, 4440.378347031418, 4448.844290449819, 4461.286194208911, 4503.81984720614, 4617.445906491243, 4625.514320996314, 4638.443386793607, 4643.558861908114, 4799.944012317284, 4849.733264670406, 4858.076965376567, 4860.756962151949, 4865.440474345354, 5153.665011774223, 5164.741762911764, 5183.533481986639, 5191.480851914778, 5205.973970130125, 4748.216544270157, 4814.253790662453, 4847.806087756591, 4856.781444835062, 4866.124097662455, 5086.287919691172, 5103.642745007814, 5109.77365432301, 5117.130087884994, 5119.027384797026, 5184.118699820964, 5187.429382767817, 5202.583793296603, 5203.583713303003, 5215.843524694265, 4956.033573453142, 5003.199488082035, 5006.4242612098615, 5040.470750571138, 5080.796768129233, 4856.611471082376, 4899.0, 4915.508449155056, 4917.237828136645, 4966.354373931365, 4861.246506791453, 4886.53577910098, 4917.852464426073, 4919.4834542373965, 4938.703677779345, 4879.316895634685, 4894.094592500399, 5039.622028347815, 5046.747662616781, 5050.444451110448, 4818.530348243819, 4863.48933362006, 4864.756762161807, 4880.707157570557, 4892.0], "value": 4697.278290237765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.4462558938704, 540.4973374761471, 548.761288839355, 555.7888002559027, 572.2674976030677, 34257.31485370294, 38180.42729359062, 38226.426603600936, 38333.0, 38349.61650383502, 38252.617473825325, 38751.22497550055, 38784.61215387845, 38825.61174388255, 38874.80562597183, 7666.846663066722, 7767.0, 7797.610119494031, 7827.3346765525, 7849.136594974549, 7449.143348514936, 7547.320741133297, 7624.275693809107, 7628.923710762904, 7634.236576342377, 7681.078270607535, 7693.538387696756, 7702.4993375430695, 7703.88143260605, 7718.073831140243, 7583.0, 7621.0, 7633.618319084079, 7646.9617651911385, 7674.232576742309, 7596.9240307596765, 7610.961945190294, 7618.162002179756, 7627.542347459114, 7662.1571627120975, 35613.643863561294, 35928.820355898315, 35961.280774384366, 35976.46035309473, 35990.64009359899, 2812.1546139854413, 2940.794144409892, 3146.937061258785, 3280.6719328067243, 3767.679747221462, 28269.57595636067, 28480.145595632162, 29364.0, 29436.264093397836, 29949.101526954008, 3475.4960530722906, 3489.7208223342072, 3606.8737594184076, 3608.368535506302, 3671.9632803672157, 250619.0, 251195.0, 251925.0, 252305.0, 252518.0, 52841.47158528365, 53055.734721326146, 53062.734686327094, 53255.0, 53261.467385326425, 47998.520014799404, 53834.0, 54909.0, 55149.44850551523, 61406.0, 12236.938815305866, 12319.076069294839, 12357.814632780515, 12387.938060309822, 12407.627771166879, 9506.47714375716, 9570.521473926276, 9610.135087842127, 9611.423314601147, 9625.614975400906, 16522.17389130563, 16589.6682066358, 16653.750193747102, 16659.750103748454, 16715.749263761052, 5993.910091348634, 6154.753809847645, 6175.876482470415, 6177.2587289525545, 6243.594166379171, 717.8528401677748, 800.6917336825364, 822.7408366364576, 937.4656445825814, 1018.2922868606247, 25387.0, 27024.86487567589, 27037.459250815267, 27039.0, 27386.17841464759, 786.9567173805381, 914.2366124286162, 931.4550987672287, 948.8007518421209, 985.3595163143871, 13811.309434528233, 14009.0, 14414.351354189086, 14518.782218266735, 14642.414303427957, 372254.0, 373208.0, 373313.0, 375009.0, 377849.0, 48189.518104818504, 48290.27564586534, 48367.75816120897, 48507.0, 48512.757436212596, 1115.4032592563103, 1125.6960620632547, 1128.0918860317522, 1146.0888593568134, 1171.824226366069, 25593.488130237663, 26004.73995260099, 26614.0, 26694.59958100669, 26831.463370732865, 41068.383974241005, 41374.37938430866, 41602.751917442525, 41608.58391416168, 41644.791776040925, 322523.0, 322804.0, 323865.0, 325021.0, 326972.0, 35742.821285893406, 35744.463833043046, 36192.45711314385, 36502.0, 36717.0, 40881.59118408897, 41429.1714165709, 41493.363052000605, 41611.58388416077, 41889.79055104705, 35113.64886351206, 35182.82408587941, 35394.29211415809, 36158.819205903805, 36909.26181476409, 35341.29317413689, 35808.28383432369, 35894.28211435809, 35933.0, 36562.26875462529, 29760.702392975792, 30000.099997000125, 30194.2451438707, 31502.0, 32444.675553244164, 28624.284392890346, 30689.232769180948, 30788.53817192699, 30817.69182308148, 31088.0, 23948.760512394652, 24088.87955560211, 24129.276121716375, 24306.27081187567, 24369.878150609133], "value": 17033.135633916947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.4500414366021, 368.2248866136782, 369.55468660264387, 382.54668218161464, 387.6162599026964, 15263.236838158089, 16574.0, 16602.169891505437, 16642.833571664294, 16732.58168545784, 12957.0, 13475.393607287671, 13622.659433514142, 13977.860221397783, 14033.578992630211, 4946.134426475362, 5231.163013917774, 5491.780328786864, 5542.944570554303, 5608.411116832735, 3415.1974286042882, 5543.473370029841, 5567.7750894803285, 5647.830565083054, 5904.2324497815225, 5898.174255604219, 5965.821025369224, 5971.4327138921735, 5971.522278217754, 5975.0439929611275, 5876.147958546008, 6343.809685709436, 6603.834904127411, 6662.300458451889, 6672.599644021374, 6264.5301602380005, 6347.079673447324, 6421.518386121013, 6454.0, 6466.321036291216, 18203.45389638313, 18315.0, 18375.356862509747, 21757.564848703096, 23064.654030189562, 1969.3402710092137, 2019.6465618516702, 2099.2337796704246, 2118.9046492907855, 2358.612721368961, 13534.593962181052, 14194.219317937612, 14222.644433889236, 14257.928710356382, 15038.924805375904, 1794.55136215946, 1864.5245462407136, 1875.353003213889, 1903.0484757621189, 1984.3451660951996, 64335.678321608095, 64838.67580662067, 77120.61439692766, 77387.22612773857, 77677.61161194215, 15297.158656273788, 15537.68924621524, 15606.843931560767, 15630.609234768994, 15632.843671563367, 26968.875913576358, 27179.320516987234, 27268.0, 27272.181834544994, 27735.445291094064, 7542.170361260257, 7852.882206766903, 7856.882146767803, 8101.918980810235, 8383.329333653293, 6313.40022697843, 6379.585326953733, 6414.518911081687, 6451.322611125858, 6614.305497922745, 7795.532268063935, 8053.0, 8055.355571554262, 8168.101508834024, 8291.0, 1516.8331483536801, 1640.516047765912, 3329.667033296651, 3399.6770306820813, 3408.522806807049, 762.3139174742776, 774.4307933668749, 850.7702920211632, 863.6631713631689, 905.307439808547, 15705.528834134995, 15725.842741572667, 16074.196290185444, 16211.918940405458, 16421.91789041047, 853.5988085599759, 854.7093988044095, 854.9829003419896, 866.5493943149653, 900.8290021049371, 8989.325800564853, 9024.097590241056, 9244.445333280024, 9369.859452108223, 9479.099485548863, 272700.0, 274489.0, 277334.0, 379986.0, 384139.0, 82862.0, 84374.0, 85220.0, 85982.14017859867, 87910.56044719863, 900.6262401103469, 911.2664305234217, 947.8530827721714, 952.3904700991371, 955.5556666150273, 14836.387532297122, 15053.849461505244, 15076.623084422978, 15189.392424303345, 15604.453844115402, 25709.742902571485, 33707.0, 36859.8160703765, 37798.81100594589, 39663.603363965995, 53502.73248633732, 53852.46147538631, 54047.72976135094, 54442.72778636082, 55281.723591381786, 7411.5553066816165, 7421.517601355895, 7474.439417043634, 7487.625618719151, 7645.350145237495, 8644.82710345777, 11341.432928353714, 11591.594294199662, 11740.70648233801, 11889.227200232302, 9567.0, 9635.373700709431, 9874.55564499585, 10062.748431289276, 10306.12397946183, 9174.587143578421, 9345.906540934775, 9884.950575247078, 9994.350367226107, 10108.646197383056, 9359.438433694, 9566.282528810229, 9646.228301735704, 9708.5145742714, 9988.850167247352, 7497.250274972459, 7522.247775222653, 7563.546187228564, 7595.0, 7660.80847978805, 8091.0, 9774.266929980138, 9850.0, 9977.60089596408, 10073.496325183858], "value": 8781.113672911852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.816424782654, 1391.9860801391985, 1454.8108745863037, 1621.2218135295066, 1637.9262933168013, 6550.606963582189, 6994.915788052847, 7149.964250178755, 7556.093268807744, 7586.696532138715, 7269.309415605522, 7453.105627324729, 7487.7753667389925, 7505.4370922180915, 7577.734779282726, 2139.572085582878, 2165.7942495462908, 2166.079416248096, 2167.869927804329, 2168.4578855286177, 2104.189886893542, 2155.6119898418356, 2192.5395666909967, 2200.7469141048823, 2203.537257175995, 2161.3191844568987, 2170.565886822642, 2171.7936796004433, 2174.5433458973635, 2192.9561408771815, 2092.780258072903, 2104.663253879372, 2107.515271487551, 2107.89460526973, 2109.98945005274, 2132.115172203534, 2173.228503881131, 2176.6082105221053, 2182.508935489518, 2182.5416662500893, 7661.310482056641, 7679.424043196726, 7680.692772289101, 7687.231276872324, 7688.654010569538, 4049.4533238012787, 4189.455370801777, 4195.811188496525, 4196.034911970233, 4208.6633069354375, 2823.265950852793, 2869.856507174654, 2928.1508362574828, 2954.2614346413397, 2963.392504536565, 882.5102068352062, 917.124146440148, 947.5025611553989, 951.0822056715303, 954.7088138117871, 9932.751681207956, 10060.647877324333, 10132.493375331203, 10140.03669651382, 10152.644657436955, 3945.467361906163, 4013.8595149169637, 4170.249355116108, 4208.494980602347, 4214.4310518079665, 8687.956560217159, 8705.0, 8712.607932643046, 8713.738587842376, 8733.519656418957, 4192.182524407711, 4229.6404805591255, 4233.555476674905, 4253.234417804825, 4256.233877901946, 3423.8288085595623, 3770.5852356240794, 3814.6757525610633, 3822.617738226211, 3865.033741564609, 3508.7894726316504, 3535.151563624763, 3585.3904836177912, 3619.5837478690287, 3665.321915445651, 1140.4012893230954, 1171.543098191706, 1184.662371224197, 1208.6917835951776, 1222.3826967381415, 794.1859593916282, 798.3094623150932, 814.9266566009088, 823.5964377455124, 832.3382910586099, 4881.658283920092, 4965.478624744422, 4977.527134922177, 5035.79856805731, 5102.55577485196, 375.46121315911756, 381.4507109761934, 388.23130202199803, 390.18646122834207, 397.598425590156, 3436.2096717755057, 3448.8448019839166, 3454.1709989602314, 3469.6877281044826, 3555.982220088935, 8815.911840881508, 9203.263738900872, 9253.72238832836, 9259.861102083474, 9304.209142222851, 9168.35821492489, 9176.770580735534, 9191.31065170115, 9196.632134714537, 9256.704061431405, 6806.319368063154, 6889.621070841152, 6977.686004129725, 6995.230524642286, 7001.649917504104, 4907.263910413324, 4910.631702622246, 5014.799408023784, 5024.045431368175, 5177.430482646831, 8342.416030877781, 8355.373346998878, 8375.078741338326, 8407.411481196257, 8483.872741909, 8434.746957591282, 8653.69712060075, 8656.91343086561, 8684.305255579664, 8734.213920747163, 6174.44430001302, 6238.376162383725, 6240.843978900564, 6292.2134733158355, 6400.295967443484, 7221.819454513679, 7270.781876543712, 7271.527350722186, 7273.599952002691, 7285.0, 6075.119107729266, 6080.543959202989, 6333.524985626004, 6334.113224148531, 6430.356964303533, 6435.002574600944, 6475.449586784987, 6568.868622627425, 6571.507136964842, 6596.67016649156, 5681.630694004876, 5751.396103409082, 5784.681842498703, 5809.680467574324, 5815.098659707752, 4374.015846434527, 4408.470983482002, 4413.646908247397, 4455.903147312587, 4569.977150114228, 4298.978505107454, 4384.0, 4403.757793321398, 4415.359772832985, 4469.0], "value": 3900.099669563614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.38728283322195, 299.9790014698972, 301.6892600621358, 301.71487943893004, 304.77751241593637, 5034.924476132856, 5036.5718913892315, 5067.873303167423, 5072.13773658478, 5082.644214904958, 4927.8912244744915, 4942.209246520558, 4957.950420495794, 4994.42564105128, 5003.699778013312, 3686.3364594372933, 3818.8472461101524, 3887.2614203301423, 3903.7657740535515, 3908.7263891527605, 3893.493845800042, 3896.688264938812, 3906.863259785908, 3917.3536366499634, 3919.764814111148, 3877.612238776114, 3890.8832735017854, 3894.4547763313158, 3906.9413958790497, 3916.373380259159, 3825.5026846509777, 3875.779129574175, 3888.0, 3938.5273767147983, 3942.1327307992196, 3431.553897993245, 3433.4506478963244, 3433.6223015468277, 3440.6559344065645, 3467.3932061889323, 4835.500994691622, 4851.223804191312, 4851.248056551241, 4880.658353915227, 4924.926126108111, 4412.0, 4451.955480445186, 4472.955270447286, 4487.640988720927, 4504.234280172379, 5170.638055336128, 5193.143131383317, 5203.453637368059, 5205.24523944026, 5214.983078299733, 3764.7176461765475, 3765.3410653135593, 3768.2840260350445, 3793.6775374093236, 3798.582155962842, 5450.4549545045575, 5510.779568817243, 5517.0, 5528.838943821802, 5542.057850165482, 3540.5751309842985, 3743.1765011697385, 3762.473253744478, 3773.9245215095543, 3777.4522694209186, 3828.444875493038, 3828.636279553438, 3833.884983450501, 3835.4246862970776, 3848.9230215395537, 4423.270160423494, 4424.247877860771, 4427.22523558376, 4439.223135951195, 4441.067375851043, 5099.107656160157, 5204.947950520446, 5208.427073021964, 5253.080710875658, 5282.81510147143, 1307.6142537951328, 1309.9148555343872, 1317.9653971632222, 1320.2836312793331, 1320.656629276395, 809.9797505062421, 827.1397746343736, 830.3979614779237, 842.751388340441, 844.9112843151504, 4340.782960851945, 4441.178381999341, 4565.0, 4580.648708630962, 4592.448906131285, 5410.431904649955, 5421.701806400607, 5423.637344846221, 5432.130859062531, 5438.0, 4583.312503124492, 4606.891870308282, 4615.9076818463445, 4618.214903466419, 4639.675222734444, 2730.3993121513236, 2866.613007244037, 2876.6979467156066, 2885.5383138697707, 2892.9026455819785, 5118.462561431071, 5128.25640282157, 5130.410002849645, 5130.615203859726, 5165.173572228426, 5312.681239125664, 5515.580340189108, 5553.140132831595, 5561.4716601923565, 5584.888302233932, 5075.974620126875, 5082.2122571001555, 5100.872478188001, 5114.641975061784, 5116.872078198075, 5396.271503346998, 5423.864403389789, 5453.427390124139, 5463.125899856004, 5472.261244731911, 5074.517920797518, 5307.389650190123, 5310.336207974004, 5345.0, 5364.946350536445, 5102.79588816458, 5113.693178409308, 5182.274481572658, 5182.300389447527, 5209.0, 3903.219356128729, 3921.8039098045556, 3962.5641179470813, 3962.7622342659533, 3963.8810835674976, 5091.898162036812, 5392.274472168869, 5421.593380496557, 5481.424450432806, 5498.45015498447, 5249.0, 5257.342832145981, 5283.181106928432, 5286.656367336111, 5291.962594401106, 5282.8943421132135, 5290.936534751527, 5310.539601609588, 5330.360356757214, 5339.652922560022, 5084.2881996521255, 5127.717975511383, 5162.8967420652125, 5166.0, 5175.870603234949, 4994.750262486788, 5159.767810448614, 5273.578113750814, 5298.97350513245, 5310.097283461898, 5163.922541161811, 5191.74041297926, 5205.843824685266, 5207.479252074762, 5220.3213582235585], "value": 3944.037904619601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.4140919649325, 734.823642325842, 739.2459691115059, 741.8367959049011, 747.7943565519481, 12013.219140755855, 13031.934840325785, 13149.0, 13173.473061077557, 13236.470541178342, 12078.335691536962, 13306.0, 13471.393787279596, 13472.932635336809, 13515.932420337884, 749.5015814483376, 766.9846603067936, 768.4083255892959, 770.0182267608816, 771.4368510986955, 629.4649547884308, 755.4221020919001, 776.7397921696239, 783.3967844759532, 784.9921500785005, 819.1276290750361, 820.5199958024563, 821.3059964330131, 822.6585966823761, 823.1110400767187, 808.462372522272, 814.5927036481759, 815.9347252219808, 816.1797393619433, 817.0971076959933, 593.7773334999375, 593.8485686150048, 594.0198672190919, 594.5362617158623, 595.8242318516048, 13076.934615326958, 13088.869111308955, 13145.737085258337, 13152.0, 13161.802572961413, 13470.326483675875, 13610.319484025758, 13634.181949083088, 13681.794773078413, 14141.151530908179, 10459.11097556701, 10625.946870265676, 10662.306950048222, 10723.410212438313, 10889.183311251687, 3265.5428240046413, 3298.307355455357, 3301.60380754311, 3302.6862448067395, 3303.504474328846, 61435.69282153605, 63811.680941595456, 64634.0, 65340.3465965339, 65596.3440365595, 10526.631567895087, 10678.893211067945, 10809.135269178447, 10814.405207713495, 10886.0, 20145.597088058155, 20148.19407223724, 20218.0, 20233.696494552594, 20543.4864128398, 7118.857622847514, 7175.17485489165, 7213.495055346076, 7234.891476627855, 7314.45141614381, 3638.945415818712, 3807.200487897517, 3813.593083940903, 3829.425586162098, 3854.209886973164, 2771.80597358183, 2882.2506148401567, 2899.869505872241, 2907.2295841601995, 2908.9818563502604, 469.3616681313411, 482.81411656512495, 482.876866399066, 483.3957553058677, 494.9653524253268, 522.1176212201367, 536.9570434365241, 547.2284079447959, 550.2599004339157, 551.9641223320472, 7522.548647081193, 7762.611869406507, 7789.0, 7952.562609056442, 8201.42663891261, 463.84895732885815, 492.7683988525387, 566.9971650141723, 571.0549041336594, 621.1828315004274, 3538.752287339913, 3570.3751843427817, 3661.23114146027, 3727.0, 3737.1965027519213, 73073.63463182756, 74849.25150748531, 93109.0, 93219.0, 94067.52966235262, 73256.0, 75175.0, 76395.61802190954, 77172.61413692895, 79994.0, 46341.53658463372, 68665.65667171632, 70170.98290170942, 72991.63504182445, 74319.25680743232, 7870.9606451967375, 8615.396922215636, 8633.30933525329, 8675.262602678842, 8713.869291960753, 42168.36747448852, 42374.788126059175, 43365.783171085204, 43775.56224437842, 45341.319880202485, 33979.830100849336, 34817.825910870284, 39020.60979390283, 60266.69866650639, 62486.68756656188, 10522.421266830397, 10541.31481453703, 10780.784384312114, 10830.891691082988, 11441.313521188755, 12845.357732113544, 12994.35028248565, 13087.934560327138, 13406.061575689608, 14036.719265614835, 10862.0, 10872.293300935415, 11264.887351126385, 11429.257098288585, 11954.701132471759, 11498.597549085742, 11634.418279085843, 11668.066554675775, 11670.0, 12338.876611233773, 10728.746963137517, 10829.945850270698, 10980.341179529254, 11161.944190279322, 11693.473793679135, 10324.948375258076, 10376.740581485523, 10741.516631751434, 10804.24370294072, 10938.890611093788, 9997.200223982209, 10166.796664066826, 10167.0, 10214.131798797185, 10234.130098941674], "value": 6442.654674820538, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 119.0, 115.0, 115.0, 117.0, 117.0, 121.0, 116.0, 116.0, 115.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 146.0, 180.0, 127.0, 148.0, 159.0, 123.0, 197.0, 130.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 166.0, 170.0, 164.0, 165.0, 163.0, 164.0, 164.0, 166.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 180.0, 77.0, 75.0, 85.0, 76.0, 160.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 154.0, 87.0, 88.0, 88.0, 147.0, 87.0, 87.0, 137.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 121.0, 117.0, 118.0, 119.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 147.0, 148.0, 152.0, 148.0, 150.0, 152.0, 148.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 63.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 68.0, 66.0, 67.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 83.0, 86.0, 86.0, 90.0, 88.0, 89.0, 88.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 143.0, 139.0, 136.0, 140.0, 145.0, 157.0, 162.0, 148.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 174.0, 176.0, 184.0, 173.0, 180.0, 190.0, 177.0, 178.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 75.0, 77.0, 72.0, 70.0, 71.0, 71.0, 69.0, 68.0], "value": 71.6, "unit": "score"}]}]} 11:38:03 INFO - Return code: 0 11:38:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:03 ERROR - # TBPL SUCCESS # 11:38:03 INFO - Running post-action listener: _resource_record_post_action 11:38:03 INFO - [mozharness: 2016-08-19 18:38:03.964308Z] Finished run-tests step (success) 11:38:03 INFO - Running post-run listener: _resource_record_post_run 11:38:04 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 412131328; Read time: 16; Write time: 373140 11:38:04 INFO - TinderboxPrint: CPU usage
13.4% 11:38:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:38:04 INFO - TinderboxPrint: I/O write bytes / time
412,131,328 / 373,140 11:38:04 INFO - TinderboxPrint: CPU idle
8,287.5 (86.6%) 11:38:04 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 11:38:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118099968; Read time: 0; Write time: 96040 11:38:04 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 294031360; Read time: 0; Write time: 277100 11:38:04 INFO - Running post-run listener: _upload_blobber_files 11:38:04 INFO - Blob upload gear active. 11:38:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:05 INFO - (blobuploader) - INFO - Done attempting. 11:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:09 INFO - (blobuploader) - INFO - Done attempting. 11:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:10 INFO - (blobuploader) - INFO - Done attempting. 11:38:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:10 INFO - Return code: 0 11:38:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dbde19933db56be7239f9c5b08be1e8526cb9aaca71d5a8b05142993bac7550a8c7485942bc9d329c369e012f1137b20492c40457c01adcb926ec37518e670bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37d3a5e4e64366dedb5cad446ac83da2e9c476a5f88aff6e838de56e9d8bec59e8c922e173c05d9c2efea2d7b2a37ae3d690d2bf08806a03b400fdbf1d487481", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28a8e5a263488539835b4fe5f3243ac3e1a9c1b26242e1070e25a2ff143c7bb9050438944e352be947b9904477c45f0d26a286905d588dd7a8f8ce2127816183"} 11:38:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:10 INFO - Contents: 11:38:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dbde19933db56be7239f9c5b08be1e8526cb9aaca71d5a8b05142993bac7550a8c7485942bc9d329c369e012f1137b20492c40457c01adcb926ec37518e670bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37d3a5e4e64366dedb5cad446ac83da2e9c476a5f88aff6e838de56e9d8bec59e8c922e173c05d9c2efea2d7b2a37ae3d690d2bf08806a03b400fdbf1d487481", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28a8e5a263488539835b4fe5f3243ac3e1a9c1b26242e1070e25a2ff143c7bb9050438944e352be947b9904477c45f0d26a286905d588dd7a8f8ce2127816183"} 11:38:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:10 INFO - Copying logs to upload dir... 11:38:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.574369 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-19 11:38:10.182594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:38:10.186570) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dbde19933db56be7239f9c5b08be1e8526cb9aaca71d5a8b05142993bac7550a8c7485942bc9d329c369e012f1137b20492c40457c01adcb926ec37518e670bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37d3a5e4e64366dedb5cad446ac83da2e9c476a5f88aff6e838de56e9d8bec59e8c922e173c05d9c2efea2d7b2a37ae3d690d2bf08806a03b400fdbf1d487481", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28a8e5a263488539835b4fe5f3243ac3e1a9c1b26242e1070e25a2ff143c7bb9050438944e352be947b9904477c45f0d26a286905d588dd7a8f8ce2127816183"} build_url:https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/ZzE1hr7VRe-KzcQ9WLh2Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dbde19933db56be7239f9c5b08be1e8526cb9aaca71d5a8b05142993bac7550a8c7485942bc9d329c369e012f1137b20492c40457c01adcb926ec37518e670bd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37d3a5e4e64366dedb5cad446ac83da2e9c476a5f88aff6e838de56e9d8bec59e8c922e173c05d9c2efea2d7b2a37ae3d690d2bf08806a03b400fdbf1d487481", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/28a8e5a263488539835b4fe5f3243ac3e1a9c1b26242e1070e25a2ff143c7bb9050438944e352be947b9904477c45f0d26a286905d588dd7a8f8ce2127816183"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 11:38:10.213962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:38:10.214422) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471630550.376542-1367714646 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 11:38:10.299813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:38:10.300249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 11:38:10.300641) ========= ========= Total master_lag: 0.18 =========