builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1471977413.85 results: success (0) buildid: 20160823063748 builduid: 16aa5038063041dfa36acd68ad413444 revision: 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:53.850646) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:53.851183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:53.851513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:53.868307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:53.868715) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 11:36:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-08-23 11:36:54 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:54.007952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:54.008364) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018461 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:54.058556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:36:54.058916) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 --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 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 --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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 11:36:54,806 truncating revision to first 12 chars 2016-08-23 11:36:54,806 Setting DEBUG logging. 2016-08-23 11:36:54,806 attempt 1/10 2016-08-23 11:36:54,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76a3bb10b02a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 11:36:55,856 unpacking tar archive at: fx-team-76a3bb10b02a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366679 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:36:55.440045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:55.440471) ========= script_repo_revision: 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:55.440968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:55.441276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:55.452248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-23 11:36:55.452717) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:36:56 INFO - MultiFileLogger online at 20160823 11:36:56 in /builds/slave/test 11:36:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:36:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:36:56 INFO - {'append_to_log': False, 11:36:56 INFO - 'base_work_dir': '/builds/slave/test', 11:36:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:36:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:36:56 INFO - 'branch': 'Fx-Team-Non-PGO', 11:36:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:36:56 INFO - 'config_files': ('talos/linux_config.py',), 11:36:56 INFO - 'default_actions': ('clobber', 11:36:56 INFO - 'read-buildbot-config', 11:36:56 INFO - 'download-and-extract', 11:36:56 INFO - 'populate-webroot', 11:36:56 INFO - 'create-virtualenv', 11:36:56 INFO - 'install', 11:36:56 INFO - 'run-tests'), 11:36:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:36:56 INFO - 'download_minidump_stackwalk': True, 11:36:56 INFO - 'download_symbols': 'ondemand', 11:36:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:36:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:36:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:36:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:36:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:36:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:36:56 INFO - 'installer_path': 'installer.exe', 11:36:56 INFO - 'log_level': 'info', 11:36:56 INFO - 'log_name': 'talos', 11:36:56 INFO - 'log_to_console': True, 11:36:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:36:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:36:56 INFO - 'opt_config_files': (), 11:36:56 INFO - 'pip_index': False, 11:36:56 INFO - 'sps_profile': False, 11:36:56 INFO - 'sps_profile_interval': 0, 11:36:56 INFO - 'suite': 'dromaeojs', 11:36:56 INFO - 'system_bits': '32', 11:36:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:36:56 INFO - 'title': 'talos-linux64-ix-034', 11:36:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:36:56 INFO - 'use_talos_json': True, 11:36:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:36:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:36:56 INFO - 'work_dir': 'build'} 11:36:56 INFO - [mozharness: 2016-08-23 18:36:56.290943Z] Running clobber step. 11:36:56 INFO - Running pre-action listener: _resource_record_pre_action 11:36:56 INFO - Running main action method: clobber 11:36:56 INFO - rmtree: /builds/slave/test/build 11:36:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:36:57 INFO - Running post-action listener: _resource_record_post_action 11:36:57 INFO - [mozharness: 2016-08-23 18:36:57.271502Z] Finished clobber step (success) 11:36:57 INFO - [mozharness: 2016-08-23 18:36:57.271603Z] Running read-buildbot-config step. 11:36:57 INFO - Running pre-action listener: _resource_record_pre_action 11:36:57 INFO - Running main action method: read_buildbot_config 11:36:57 INFO - Using buildbot properties: 11:36:57 INFO - { 11:36:57 INFO - "project": "", 11:36:57 INFO - "product": "firefox", 11:36:57 INFO - "script_repo_revision": "production", 11:36:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:36:57 INFO - "repository": "", 11:36:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:36:57 INFO - "buildid": "20160823063748", 11:36:57 INFO - "pgo_build": "False", 11:36:57 INFO - "basedir": "/builds/slave/test", 11:36:57 INFO - "buildnumber": 1879, 11:36:57 INFO - "slavename": "talos-linux64-ix-034", 11:36:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:36:57 INFO - "platform": "ubuntu64_hw", 11:36:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:36:57 INFO - "branch": "fx-team", 11:36:57 INFO - "repo_path": "integration/fx-team", 11:36:57 INFO - "revision": "76a3bb10b02aa23b469ea1cc1c90d4b4b3619433", 11:36:57 INFO - "stage_platform": "linux64", 11:36:57 INFO - "builduid": "16aa5038063041dfa36acd68ad413444", 11:36:57 INFO - "slavebuilddir": "test" 11:36:57 INFO - } 11:36:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:36:57 INFO - Running post-action listener: _resource_record_post_action 11:36:57 INFO - [mozharness: 2016-08-23 18:36:57.274069Z] Finished read-buildbot-config step (success) 11:36:57 INFO - [mozharness: 2016-08-23 18:36:57.274157Z] Running download-and-extract step. 11:36:57 INFO - Running pre-action listener: _resource_record_pre_action 11:36:57 INFO - Running main action method: download_and_extract 11:36:57 INFO - mkdir: /builds/slave/test/build/tests 11:36: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:36:57 INFO - trying https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:36:57 INFO - Downloading https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:36:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:36:57 INFO - Downloaded 1361 bytes. 11:36:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:36:57 INFO - Using the following test package requirements: 11:36:57 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:36:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:36:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:36:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'jsshell-linux-x86_64.zip'], 11:36:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:36:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:36:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:36:57 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:36:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:36:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:36:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:36: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:36:57 INFO - trying https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:36:57 INFO - Downloading https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:36:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:36:58 INFO - Downloaded 20330904 bytes. 11:36:58 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:37:03 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:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:03 INFO - trying https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:03 INFO - Downloaded 20330904 bytes. 11:37:03 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:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:08 INFO - trying https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:08 INFO - Downloading https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:09 INFO - Downloaded 14413981 bytes. 11:37:09 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:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:09 INFO - trying https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/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:37:11 INFO - Downloaded 55758423 bytes. 11:37:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:11 INFO - mkdir: /builds/slave/test/properties 11:37:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:11 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:11 INFO - Contents: 11:37:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - Running post-action listener: set_extra_try_arguments 11:37:12 INFO - [mozharness: 2016-08-23 18:37:12.398720Z] Finished download-and-extract step (success) 11:37:12 INFO - [mozharness: 2016-08-23 18:37:12.398945Z] Running populate-webroot step. 11:37:12 INFO - Running pre-action listener: _resource_record_pre_action 11:37:12 INFO - Running main action method: populate_webroot 11:37:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:12 INFO - '--tppagecycles', 11:37:12 INFO - '7'], 11:37:12 INFO - 'tests': ['tsvgm']}}, 11:37:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['damp', 'tps']}, 11:37:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['damp', 'tps']}, 11:37:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['dromaeo_dom']}, 11:37:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['basic_compositor_video']}, 11:37:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:37:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['a11yr', 11:37:12 INFO - 'ts_paint', 11:37:12 INFO - 'tpaint', 11:37:12 INFO - 'sessionrestore', 11:37:12 INFO - 'sessionrestore_no_auto_restore', 11:37:12 INFO - 'tabpaint']}, 11:37:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['tsvgx', 11:37:12 INFO - 'tsvgr_opacity', 11:37:12 INFO - 'tart', 11:37:12 INFO - 'tscrollx', 11:37:12 INFO - 'cart']}, 11:37:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:12 INFO - 'tsvgr_opacity', 11:37:12 INFO - 'tart', 11:37:12 INFO - 'tscrollx', 11:37:12 INFO - 'cart']}, 11:37:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--disable-e10s'], 11:37:12 INFO - 'tests': ['tp5o']}, 11:37:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'tests': ['tp5o']}, 11:37:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--disable-e10s', 11:37:12 INFO - '--xperf_path', 11:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:12 INFO - 'tests': ['tp5n']}, 11:37:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:12 INFO - 'talos_options': ['--xperf_path', 11:37:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:12 INFO - 'tests': ['tp5n']}}, 11:37:12 INFO - 'talos.zip': {'path': '', 11:37:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - [mozharness: 2016-08-23 18:37:12.416136Z] Finished populate-webroot step (success) 11:37:12 INFO - [mozharness: 2016-08-23 18:37:12.416224Z] Running create-virtualenv step. 11:37:12 INFO - Running pre-action listener: _resource_record_pre_action 11:37:12 INFO - Running main action method: create_virtualenv 11:37:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:12 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:37:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:12 INFO - Using real prefix '/usr' 11:37:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:14 INFO - Installing pip.................done. 11:37:14 INFO - Return code: 0 11:37:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:14 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:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:14 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:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:14 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:14 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:37:14 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:37:14 INFO - Using env: {'DISPLAY': ':0', 11:37:14 INFO - 'HOME': '/home/cltbld', 11:37:14 INFO - 'LANG': 'en_US.UTF-8', 11:37:14 INFO - 'LANGUAGE': 'en_US:en', 11:37:14 INFO - 'LOGNAME': 'cltbld', 11:37:14 INFO - 'MAIL': '/var/mail/cltbld', 11:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:14 INFO - 'MOZ_NO_REMOTE': '1', 11:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:14 INFO - 'NO_EM_RESTART': '1', 11:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:15 INFO - 'PWD': '/builds/slave/test', 11:37:15 INFO - 'SHELL': '/bin/bash', 11:37:15 INFO - 'SHLVL': '1', 11:37:15 INFO - 'TERM': 'linux', 11:37:15 INFO - 'TMOUT': '86400', 11:37:15 INFO - 'USER': 'cltbld', 11:37:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:15 INFO - '_': '/tools/buildbot/bin/python'} 11:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:15 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:37:15 INFO - Cleaning up... 11:37:15 INFO - Return code: 0 11:37:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:15 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:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:15 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:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:15 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:15 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:37:15 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:37:15 INFO - Using env: {'DISPLAY': ':0', 11:37:15 INFO - 'HOME': '/home/cltbld', 11:37:15 INFO - 'LANG': 'en_US.UTF-8', 11:37:15 INFO - 'LANGUAGE': 'en_US:en', 11:37:15 INFO - 'LOGNAME': 'cltbld', 11:37:15 INFO - 'MAIL': '/var/mail/cltbld', 11:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:15 INFO - 'MOZ_NO_REMOTE': '1', 11:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:15 INFO - 'NO_EM_RESTART': '1', 11:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:15 INFO - 'PWD': '/builds/slave/test', 11:37:15 INFO - 'SHELL': '/bin/bash', 11:37:15 INFO - 'SHLVL': '1', 11:37:15 INFO - 'TERM': 'linux', 11:37:15 INFO - 'TMOUT': '86400', 11:37:15 INFO - 'USER': 'cltbld', 11:37:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:15 INFO - '_': '/tools/buildbot/bin/python'} 11:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:15 INFO - Downloading/unpacking psutil>=3.1.1 11:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:17 INFO - Installing collected packages: psutil 11:37:17 INFO - Running setup.py install for psutil 11:37:17 INFO - building 'psutil._psutil_linux' extension 11:37:17 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:37:17 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:37:17 INFO - building 'psutil._psutil_posix' extension 11:37:17 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:37:17 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:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:17 INFO - Successfully installed psutil 11:37:17 INFO - Cleaning up... 11:37:17 INFO - Return code: 0 11:37:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:17 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:17 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:37:17 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:37:17 INFO - Using env: {'DISPLAY': ':0', 11:37:17 INFO - 'HOME': '/home/cltbld', 11:37:17 INFO - 'LANG': 'en_US.UTF-8', 11:37:17 INFO - 'LANGUAGE': 'en_US:en', 11:37:17 INFO - 'LOGNAME': 'cltbld', 11:37:17 INFO - 'MAIL': '/var/mail/cltbld', 11:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:17 INFO - 'MOZ_NO_REMOTE': '1', 11:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:17 INFO - 'NO_EM_RESTART': '1', 11:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:17 INFO - 'PWD': '/builds/slave/test', 11:37:17 INFO - 'SHELL': '/bin/bash', 11:37:17 INFO - 'SHLVL': '1', 11:37:17 INFO - 'TERM': 'linux', 11:37:17 INFO - 'TMOUT': '86400', 11:37:17 INFO - 'USER': 'cltbld', 11:37:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:17 INFO - '_': '/tools/buildbot/bin/python'} 11:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:37:20 INFO - Installing collected packages: mozsystemmonitor 11:37:20 INFO - Running setup.py install for mozsystemmonitor 11:37:20 INFO - Successfully installed mozsystemmonitor 11:37:20 INFO - Cleaning up... 11:37:20 INFO - Return code: 0 11:37:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:20 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:20 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:37:20 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:37:20 INFO - Using env: {'DISPLAY': ':0', 11:37:20 INFO - 'HOME': '/home/cltbld', 11:37:20 INFO - 'LANG': 'en_US.UTF-8', 11:37:20 INFO - 'LANGUAGE': 'en_US:en', 11:37:20 INFO - 'LOGNAME': 'cltbld', 11:37:20 INFO - 'MAIL': '/var/mail/cltbld', 11:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:20 INFO - 'MOZ_NO_REMOTE': '1', 11:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:20 INFO - 'NO_EM_RESTART': '1', 11:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:20 INFO - 'PWD': '/builds/slave/test', 11:37:20 INFO - 'SHELL': '/bin/bash', 11:37:20 INFO - 'SHLVL': '1', 11:37:20 INFO - 'TERM': 'linux', 11:37:20 INFO - 'TMOUT': '86400', 11:37:20 INFO - 'USER': 'cltbld', 11:37:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:20 INFO - '_': '/tools/buildbot/bin/python'} 11:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:20 INFO - Downloading/unpacking jsonschema==2.5.1 11:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 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:37:22 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:22 INFO - warning: no files found matching '*.txt' 11:37:22 INFO - no previously-included directories found matching 'build' 11:37:22 INFO - no previously-included directories found matching 'dist' 11:37:22 INFO - no previously-included directories found matching '.git*' 11:37:22 INFO - Installing collected packages: jsonschema, functools32 11:37:22 INFO - Running setup.py install for functools32 11:37:22 INFO - warning: no files found matching '*.txt' 11:37:22 INFO - no previously-included directories found matching 'build' 11:37:22 INFO - no previously-included directories found matching 'dist' 11:37:22 INFO - no previously-included directories found matching '.git*' 11:37:22 INFO - Successfully installed jsonschema functools32 11:37:22 INFO - Cleaning up... 11:37:22 INFO - Return code: 0 11:37:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:37:22 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:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:22 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:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:22 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:22 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:37:22 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:37:22 INFO - Using env: {'DISPLAY': ':0', 11:37:22 INFO - 'HOME': '/home/cltbld', 11:37:22 INFO - 'LANG': 'en_US.UTF-8', 11:37:22 INFO - 'LANGUAGE': 'en_US:en', 11:37:22 INFO - 'LOGNAME': 'cltbld', 11:37:22 INFO - 'MAIL': '/var/mail/cltbld', 11:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:22 INFO - 'MOZ_NO_REMOTE': '1', 11:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:22 INFO - 'NO_EM_RESTART': '1', 11:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:22 INFO - 'PWD': '/builds/slave/test', 11:37:22 INFO - 'SHELL': '/bin/bash', 11:37:22 INFO - 'SHLVL': '1', 11:37:22 INFO - 'TERM': 'linux', 11:37:22 INFO - 'TMOUT': '86400', 11:37:22 INFO - 'USER': 'cltbld', 11:37:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:22 INFO - '_': '/tools/buildbot/bin/python'} 11:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:37:23 INFO - Cleaning up... 11:37:23 INFO - Return code: 0 11:37:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:23 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:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 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:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:23 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:23 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:37:23 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:37:23 INFO - Using env: {'DISPLAY': ':0', 11:37:23 INFO - 'HOME': '/home/cltbld', 11:37:23 INFO - 'LANG': 'en_US.UTF-8', 11:37:23 INFO - 'LANGUAGE': 'en_US:en', 11:37:23 INFO - 'LOGNAME': 'cltbld', 11:37:23 INFO - 'MAIL': '/var/mail/cltbld', 11:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:23 INFO - 'MOZ_NO_REMOTE': '1', 11:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:23 INFO - 'NO_EM_RESTART': '1', 11:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:23 INFO - 'PWD': '/builds/slave/test', 11:37:23 INFO - 'SHELL': '/bin/bash', 11:37:23 INFO - 'SHLVL': '1', 11:37:23 INFO - 'TERM': 'linux', 11:37:23 INFO - 'TMOUT': '86400', 11:37:23 INFO - 'USER': 'cltbld', 11:37:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:23 INFO - '_': '/tools/buildbot/bin/python'} 11:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 INFO - Downloading docopt-0.6.1.tar.gz 11:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:25 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:25 INFO - Running setup.py install for blobuploader 11:37:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:25 INFO - Running setup.py install for requests 11:37:26 INFO - Running setup.py install for docopt 11:37:26 INFO - Successfully installed blobuploader requests docopt 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:26 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:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:26 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:37:26 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:37:26 INFO - Using env: {'DISPLAY': ':0', 11:37:26 INFO - 'HOME': '/home/cltbld', 11:37:26 INFO - 'LANG': 'en_US.UTF-8', 11:37:26 INFO - 'LANGUAGE': 'en_US:en', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MAIL': '/var/mail/cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SHLVL': '1', 11:37:26 INFO - 'TERM': 'linux', 11:37:26 INFO - 'TMOUT': '86400', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - '_': '/tools/buildbot/bin/python'} 11:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:26 INFO - Running setup.py (path:/tmp/pip-J053c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:26 INFO - Running setup.py (path:/tmp/pip-o1tCZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:26 INFO - Running setup.py (path:/tmp/pip-3TSQAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:26 INFO - Running setup.py (path:/tmp/pip-2EX1NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:27 INFO - Running setup.py (path:/tmp/pip-hRETlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:27 INFO - Running setup.py (path:/tmp/pip-8lfrSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:27 INFO - Running setup.py (path:/tmp/pip-sXRy5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:27 INFO - Running setup.py (path:/tmp/pip-nsEOIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:27 INFO - Running setup.py (path:/tmp/pip-hu_fGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:27 INFO - Running setup.py (path:/tmp/pip-ovMREj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:27 INFO - Running setup.py (path:/tmp/pip-BTYQ2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:27 INFO - Running setup.py (path:/tmp/pip-0DsxIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:27 INFO - Running setup.py (path:/tmp/pip-ohBf8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:27 INFO - Running setup.py (path:/tmp/pip-VLJCKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:27 INFO - Running setup.py (path:/tmp/pip-e7UH74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:27 INFO - Running setup.py (path:/tmp/pip-8da7ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:27 INFO - Running setup.py (path:/tmp/pip-vx8SSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:27 INFO - Running setup.py install for manifestparser 11:37:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Running setup.py install for mozcrash 11:37:28 INFO - Running setup.py install for mozdebug 11:37:28 INFO - Running setup.py install for mozdevice 11:37:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Running setup.py install for mozfile 11:37:28 INFO - Running setup.py install for mozhttpd 11:37:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Running setup.py install for mozinfo 11:37:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Running setup.py install for mozInstall 11:37:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:28 INFO - Running setup.py install for mozleak 11:37:28 INFO - Running setup.py install for mozlog 11:37:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Running setup.py install for moznetwork 11:37:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Running setup.py install for mozprocess 11:37:29 INFO - Running setup.py install for mozprofile 11:37:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Running setup.py install for mozrunner 11:37:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Running setup.py install for mozscreenshot 11:37:29 INFO - Running setup.py install for moztest 11:37:29 INFO - Running setup.py install for mozversion 11:37:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:29 INFO - Cleaning up... 11:37:29 INFO - Return code: 0 11:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:29 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:29 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:37:29 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:37:29 INFO - Using env: {'DISPLAY': ':0', 11:37:29 INFO - 'HOME': '/home/cltbld', 11:37:29 INFO - 'LANG': 'en_US.UTF-8', 11:37:29 INFO - 'LANGUAGE': 'en_US:en', 11:37:29 INFO - 'LOGNAME': 'cltbld', 11:37:29 INFO - 'MAIL': '/var/mail/cltbld', 11:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:29 INFO - 'MOZ_NO_REMOTE': '1', 11:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:29 INFO - 'NO_EM_RESTART': '1', 11:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:29 INFO - 'PWD': '/builds/slave/test', 11:37:29 INFO - 'SHELL': '/bin/bash', 11:37:29 INFO - 'SHLVL': '1', 11:37:29 INFO - 'TERM': 'linux', 11:37:29 INFO - 'TMOUT': '86400', 11:37:29 INFO - 'USER': 'cltbld', 11:37:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:29 INFO - '_': '/tools/buildbot/bin/python'} 11:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:30 INFO - Running setup.py (path:/tmp/pip-FWKHLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 INFO - Running setup.py (path:/tmp/pip-VSrl1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 INFO - Running setup.py (path:/tmp/pip-pJ9Qdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 INFO - Running setup.py (path:/tmp/pip-9mQwQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:30 INFO - Running setup.py (path:/tmp/pip-8NGX1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 INFO - Running setup.py (path:/tmp/pip-BqPreg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 INFO - Running setup.py (path:/tmp/pip-6XcMBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:30 INFO - Running setup.py (path:/tmp/pip-YwtdvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:30 INFO - Running setup.py (path:/tmp/pip-hJNcox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:30 INFO - Running setup.py (path:/tmp/pip-5QG7PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:30 INFO - Running setup.py (path:/tmp/pip-MuGv66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:30 INFO - Running setup.py (path:/tmp/pip-0zOkVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:30 INFO - Running setup.py (path:/tmp/pip-76_2Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:30 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:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:30 INFO - Running setup.py (path:/tmp/pip-DmQ7SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:31 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:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:31 INFO - Running setup.py (path:/tmp/pip-_Fyxge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:31 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:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:31 INFO - Running setup.py (path:/tmp/pip-g3oE1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:31 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:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:31 INFO - Running setup.py (path:/tmp/pip-MCzk3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:31 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:37:33 INFO - Downloading blessings-1.6.tar.gz 11:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:33 INFO - Installing collected packages: blessings 11:37:33 INFO - Running setup.py install for blessings 11:37:33 INFO - Successfully installed blessings 11:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:33 INFO - Reading from file tmpfile_stdout 11:37:33 INFO - Current package versions: 11:37:33 INFO - argparse == 1.2.1 11:37:33 INFO - blessings == 1.6 11:37:33 INFO - blobuploader == 1.2.4 11:37:33 INFO - docopt == 0.6.1 11:37:33 INFO - functools32 == 3.2.3-2 11:37:33 INFO - jsonschema == 2.5.1 11:37:33 INFO - manifestparser == 1.1 11:37:33 INFO - mozInstall == 1.12 11:37:33 INFO - mozcrash == 0.17 11:37:33 INFO - mozdebug == 0.1 11:37:33 INFO - mozdevice == 0.48 11:37:33 INFO - mozfile == 1.2 11:37:33 INFO - mozhttpd == 0.7 11:37:33 INFO - mozinfo == 0.9 11:37:33 INFO - mozleak == 0.1 11:37:33 INFO - mozlog == 3.3 11:37:33 INFO - moznetwork == 0.27 11:37:33 INFO - mozprocess == 0.23 11:37:33 INFO - mozprofile == 0.28 11:37:33 INFO - mozrunner == 6.12 11:37:33 INFO - mozscreenshot == 0.1 11:37:33 INFO - mozsystemmonitor == 0.3 11:37:33 INFO - moztest == 0.7 11:37:33 INFO - mozversion == 1.4 11:37:33 INFO - psutil == 3.1.1 11:37:33 INFO - requests == 1.2.3 11:37:33 INFO - wsgiref == 0.1.2 11:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:33 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:37:33 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:37:33 INFO - Using env: {'DISPLAY': ':0', 11:37:33 INFO - 'HOME': '/home/cltbld', 11:37:33 INFO - 'LANG': 'en_US.UTF-8', 11:37:33 INFO - 'LANGUAGE': 'en_US:en', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MAIL': '/var/mail/cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SHLVL': '1', 11:37:33 INFO - 'TERM': 'linux', 11:37:33 INFO - 'TMOUT': '86400', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - '_': '/tools/buildbot/bin/python'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 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:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x7f7cc4a0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf91230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', '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:37:33 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:37:33 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:37:33 INFO - Using env: {'DISPLAY': ':0', 11:37:33 INFO - 'HOME': '/home/cltbld', 11:37:33 INFO - 'LANG': 'en_US.UTF-8', 11:37:33 INFO - 'LANGUAGE': 'en_US:en', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MAIL': '/var/mail/cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SHLVL': '1', 11:37:33 INFO - 'TERM': 'linux', 11:37:33 INFO - 'TMOUT': '86400', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - '_': '/tools/buildbot/bin/python'} 11:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:37:34 INFO - Cleaning up... 11:37:34 INFO - Return code: 0 11:37:34 INFO - Running post-action listener: _resource_record_post_action 11:37:34 INFO - Running post-action listener: _start_resource_monitoring 11:37:34 INFO - Starting resource monitoring. 11:37:34 INFO - [mozharness: 2016-08-23 18:37:34.068918Z] Finished create-virtualenv step (success) 11:37:34 INFO - [mozharness: 2016-08-23 18:37:34.069535Z] Running install step. 11:37:34 INFO - Running pre-action listener: _resource_record_pre_action 11:37:34 INFO - Running main action method: install 11:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:34 INFO - Reading from file tmpfile_stdout 11:37:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:37:34 INFO - Reading from file tmpfile_stdout 11:37:34 INFO - Output received: 11:37:34 INFO - Usage: mozinstall [options] installer 11:37:34 INFO - Options: 11:37:34 INFO - -h, --help show this help message and exit 11:37:34 INFO - -d DEST, --destination=DEST 11:37:34 INFO - Directory to install application into. [default: 11:37:34 INFO - "/builds/slave/test"] 11:37:34 INFO - --app=APP Application being installed. [default: firefox] 11:37:34 INFO - mkdir: /builds/slave/test/build/application 11:37:34 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:37:34 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:37:50 INFO - Reading from file tmpfile_stdout 11:37:50 INFO - Output received: 11:37:50 INFO - /builds/slave/test/build/application/firefox/firefox 11:37:50 INFO - Running post-action listener: _resource_record_post_action 11:37:50 INFO - [mozharness: 2016-08-23 18:37:50.514008Z] Finished install step (success) 11:37:50 INFO - [mozharness: 2016-08-23 18:37:50.514343Z] Running run-tests step. 11:37:50 INFO - Running pre-action listener: _resource_record_pre_action 11:37:50 INFO - Running main action method: run_tests 11:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:50 INFO - Python 2.7.3 11:37:50 INFO - Return code: 0 11:37:50 INFO - grabbing minidump binary from tooltool 11:37: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:37:50 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 0xf8b090>, '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 0xf8e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37:50 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:37:50 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:37:50 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:37:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:50 INFO - Return code: 0 11:37:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:37:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:37:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:37:50 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:37:50 INFO - Using env: {'DISPLAY': ':0', 11:37:50 INFO - 'HOME': '/home/cltbld', 11:37:50 INFO - 'LANG': 'en_US.UTF-8', 11:37:50 INFO - 'LANGUAGE': 'en_US:en', 11:37:50 INFO - 'LOGNAME': 'cltbld', 11:37:50 INFO - 'MAIL': '/var/mail/cltbld', 11:37:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:50 INFO - 'MOZ_NO_REMOTE': '1', 11:37:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:50 INFO - 'NO_EM_RESTART': '1', 11:37:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:50 INFO - 'PWD': '/builds/slave/test', 11:37:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:50 INFO - 'SHELL': '/bin/bash', 11:37:50 INFO - 'SHLVL': '1', 11:37:50 INFO - 'TERM': 'linux', 11:37:50 INFO - 'TMOUT': '86400', 11:37:50 INFO - 'USER': 'cltbld', 11:37:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431', 11:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:50 INFO - '_': '/tools/buildbot/bin/python'} 11:37:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:37:50 INFO - mozversion application_buildid: 20160823063748 11:37:50 INFO - mozversion application_changeset: 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 11:37:50 INFO - mozversion application_display_name: Nightly 11:37:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:50 INFO - mozversion application_name: Firefox 11:37:50 INFO - mozversion application_remotingname: firefox 11:37:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:37:50 INFO - mozversion application_vendor: Mozilla 11:37:50 INFO - mozversion application_version: 51.0a1 11:37:50 INFO - mozversion platform_buildid: 20160823063748 11:37:50 INFO - mozversion platform_changeset: 76a3bb10b02aa23b469ea1cc1c90d4b4b3619433 11:37:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:37:50 INFO - mozversion platform_version: 51.0a1 11:37:50 INFO - using testdate: 1471977470 11:37:50 INFO - actual date: 1471977470 11:37:50 INFO - starting webserver on 'localhost:35658' 11:37:50 INFO - SUITE-START | Running 2 tests 11:37:50 INFO - TEST-START | dromaeo_css 11:37:50 INFO - operating with platform_type : linux_ 11:37:50 INFO - Initialising browser for dromaeo_css test... 11:37:50 INFO - TEST-INFO | started process 6502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVfGegD/profile http://localhost:35658/getInfo.html) 11:37:55 INFO - PROCESS | 6502 | __metrics Screen width/height:1600/1200 11:37:55 INFO - PROCESS | 6502 | colorDepth:24 11:37:55 INFO - PROCESS | 6502 | Browser inner width/height: 1024/697 11:37:55 INFO - PROCESS | 6502 | __metrics 11:37:55 INFO - PROCESS | 6502 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:37:55 INFO - PROCESS | 6502 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:56 INFO - PROCESS | 6502 | console.error: PushService: 11:37:56 INFO - PROCESS | 6502 | stateChangeProcessEnqueue: Error transitioning state 11:37:56 INFO - PROCESS | 6502 | UnknownError 11:37:57 INFO - TEST-INFO | 6502: exit 0 11:37:57 INFO - Browser initialized. 11:37:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:57 INFO - TEST-INFO | started process 6582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVfGegD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:09 INFO - PROCESS | 6582 | RSS: Main: 175685632 11:38:09 INFO - PROCESS | 6582 | 11:39:00 INFO - PROCESS | 6582 | 1471977540447 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:41:13 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35658/tests/dromaeo/cssquery-ext.html) 11:41:14 INFO - PROCESS | 6582 | RSS: Main: 268709888 11:41:14 INFO - PROCESS | 6582 | 11:44:17 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-ext.html (next: http://localhost:35658/tests/dromaeo/cssquery-jquery.html) 11:44:18 INFO - PROCESS | 6582 | RSS: Main: 271794176 11:44:18 INFO - PROCESS | 6582 | 11:47:20 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35658/tests/dromaeo/cssquery-mootools.html) 11:47:21 INFO - PROCESS | 6582 | RSS: Main: 275320832 11:47:21 INFO - PROCESS | 6582 | 11:50:23 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35658/tests/dromaeo/cssquery-prototype.html) 11:50:24 INFO - PROCESS | 6582 | RSS: Main: 218660864 11:50:24 INFO - PROCESS | 6582 | 11:53:27 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35658/tests/dromaeo/cssquery-yui.html) 11:53:28 INFO - PROCESS | 6582 | RSS: Main: 220037120 11:53:28 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | Cycle 1(1): loaded http://localhost:35658/tests/dromaeo/cssquery-yui.html (next: http://localhost:35658/tests/dromaeo/cssquery-dojo.html) 11:56:31 INFO - PROCESS | 6582 | RSS: Main: 298307584 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | __start_tp_report 11:56:31 INFO - PROCESS | 6582 | _x_x_mozilla_page_load 11:56:31 INFO - PROCESS | 6582 | _x_x_mozilla_page_load_details 11:56:31 INFO - PROCESS | 6582 | |i|pagename|runs| 11:56:31 INFO - PROCESS | 6582 | |0;dojo.html;2603.8437693738374;2646.2722751243414;2650.814442988989;2659.6542449481576;2673.78609711223;4657.0453057123295;4666.743329116897;4714.858554243369;4756.429228492581;4778.331033655287;4668.719876807386;4714.363560919283;4726.645501587377;4760.714357138574;4856.417229932405;4139.3583994480905;4364.956350436502;4416.1609294233995;4429.64562834974;4434.49003364614;4414.05097903949;4438.600525952664;4451.577100175478;4465.106978604276;4478.350639157336;4203.516595591515;4279.186954478639;4316.309390497506;4330.9605694633065;4354.281543545311;4390.034192477649;4391.714538555016;4393.143337049277;4395.4725432947935;4400.823967041314;4352.586504282088;4363.890902727458;4386.166628340605;4391.824327026915;4394.099209662011;4611.792469338888;4659.091477161955;4700.130475861943;4708.529147085298;4775.2359622460235;5092.796288148506;5101.464346243628;5109.233614957749;5110.488951104897;5122.718250496221;5142.254373115915;5149.485051494858;5153.407358153823;5157.53582177602;5168.069747445458;4626.306054091846;4657.813687452532;4694.248920172756;4701.341812146234;4787.090452813989;5169.53474187325;5190.325257716473;5194.792208311701;5197.636165468381;5202.661826981234;4995.825146119941;4998.850034498971;5002.374703162105;5004.699718016931;5011.974940125276;4861.756912154378;4885.877853053702;4912.975435122801;4918.0901533216465;5065.138926382524;4945.876353091202;4950.529699678525;4950.579200767903;4951.257311403247;4952.232403977389;4936.8765780855765;4944.90110197794;4949.554540091409;4951.430585482715;4952.579030782424;4166.812493437742;4206.85276015338;4209.515905670887;4247.256730072225;4294.742315461082;3710.1466662667735;3753.0992561784974;3780.640839120279;3791.1469919268498;3810.333191691443;4375.584319489643;4377.299632058919;4385.693001489929;4386.298192289219;4390.7705842364185;4779.737114458669;5091.803426194841;5130;5139.306193663882;5146.125158723026;4282.785860706952;4324.459442569679;4336.089421221515;4375;4389.868303950887;4591.678582499259;4600.53994600544;4602.286645569942;4603.95396046042;4606.976965115153;4588.609968152745;4756.643251756063;4795.064962332312;4802.943352462453;4808.734435792801;4928.8767780805765;4969.229769385751;4984.17761069434;5088.974555127201;5089.999999999852;4783.402074740658;4785.234362501983;4792.928106078341;4793.424789025339;4799.136155492045;4764.952350476589;5019.272205530251;5026.773795179299;5034.622403319839;5034.974825125851;4971.37857767779;5000.199968005102;5031.345925029723;5080.517350851663;5101.566366858859;4960.70235785854;4965.82619608312;4966.528179822911;4975.800967961241;4976.651634385558;4786.856394308176;4952.083864485082;4962.528559786959;4968.453470118357;4968.975155124202;4760.476347601831;4783.7129772213775;4808.831690890802;4845.8061677533915;4869.561739443326;4947.554720075211;4991.750412479289;4992.101421744121;4992.350994370709;4993.825216117564;4663.510331415288;4696.272077827942;4871.975640121776;4891.51084891508;4893.6085113191575 11:56:31 INFO - PROCESS | 6582 | |1;ext.html;553.3056014701549;554.947280008399;554.9539118761136;562.2718579439626;563.5322682173796;37890;39370.80314598427;39593.406098908505;43934.12131757363;44090;40760.18479630406;41217.58782412175;41252;41283.380749288786;41371.79314103425;7721.189275126129;7867.370610351187;7910.7626771196665;7918.208179182093;7925.920740792576;7653.885191722128;7740.574268415235;7745.3029227369525;7745.883811742829;7747.109082455533;7706.845863082735;7725.690972361127;7747.573883436408;7759.728409505668;7762.961185194066;7688.615569221544;7693.153753087156;7719.150893401749;7722.53664780115;7727.420443466706;7600.8479830403085;7652.464327497078;7670.463067585271;7673.271039251262;7673.46285759997;38875.22249555022;38980.41529377033;39243.80378098091;39246;39295.41056884149;2843.6587609486787;2993.3724597756295;3058.602381690366;3331.4503106987318;3348.3303339332233;28880.42239155226;29116.563251551244;29216.26959326034;29464.70535294641;29999.550006749916;2927.34134819666;3034.544818277254;3066.4480393529157;3092.752579793611;3112.828794416306;260860;262109.72067374105;262196;262329;262786;53054.7347263269;53289.2006619901;53346.46653533415;53413;53425.11635347473;32576.837115814742;33442.49836252458;33479.832600837326;35268;56293;13737.931310343385;13816.37826297819;13877.306134693225;13893;13959.092658977133;9681.806363872824;9705.902940970642;9736.610535578639;9765.218782497383;9788.510574471391;17987;18228.088595570167;18235.270589176285;18293.7255941161;18347.81652183461;6625.701843417058;6719.260881303053;7015.579065256101;7015.859682806417;7016.789496315118;733.611186071383;913.159892898535;950.9714708558754;983.2085171437062;1015.0914931136591;27529.174124776287;28080.438391232063;28109.297267568476;28170.85914570414;28943.276418089295;868.917452841979;923.5890028937058;956.4357029352576;966.5940305071887;996.1881066930429;14203.857961420461;14702.926485367505;15043.247837608076;15169.469068582546;15513.844861551466;387696;389435;391856;392830;393892;49363.506364936606;49457.25814112791;49674;49680;49786.75106624444;1019.5870672377699;1090.6782499162766;1165.2018367418345;1173.8004539228352;1201.297241113958;25596.744032559436;28879.42241155207;29516.557251640814;29596.16181485009;29976.700232998264;41867;42325.57674423217;42515.3622695666;42523;42591.36112958246;280121;281727;281823;282252;282377;22539.32382028542;24660.876695616407;25686;25852.095176668725;26045.739542604333;38771.22457550777;39047.80476097715;39337.80331098326;39743.60256397399;40360.1927961445;33303.50044749379;33392.49911251284;33445.498317525744;33870.491942620385;34313;33554.49668255027;33628.663713362555;33644.32711345809;33914;34201.06687730943;32855.17862053468;33709.66290337163;33735.83132084324;34210.14474638154;34318.313633726684;28097.157085287476;30433.239169020067;30535.54196687007;30768.846280727754;30777.538336924517;23453.76546234516;23666.88166559225;23895.283141505784;24261;24320.87839560791 11:56:31 INFO - PROCESS | 6582 | |2;jquery.html;336.35252139631234;356.23942881947045;357.71382893685063;358.1887025886367;382.5619665483022;12783.680407989805;16099.436519721812;16341.264643091075;17633.823661763377;17815.37646182384;15302.617434564141;15806.288717007734;15929.769832223468;16172.27224774885;16296.103714295708;4940.901181976367;5161.458046905077;6567.146270984766;6861.622610756406;6920.930790692104;4047.615476529725;5350.635587925074;6857.3828355448;7026.1217347831525;7030.242439390153;7005.509614326999;7121.394681452057;7124.109486314211;7132.286771322878;7135.964320178417;6777.186737591521;6836.4530837533375;6841;6888.4144847688;7099.396551293146;6477.967610161966;6644.767433139817;6657.933420665829;6660.134182556285;6665.366790154928;23408.64887026696;23873.16443924454;24149.15477958263;24171.395715107086;24527.754722452904;1836.7244913263116;1934.6904495280687;1993.2824183294003;2026.6554685703318;2034.6947957806299;13801.309934503235;13935.651608709763;14561.344739486749;14910.62723431912;15390.3074361654;1819.2631984046482;1884.679604467244;1890.7920128785822;1912.177763561668;1933.497290704413;67284;80656.59671701663;81486.59256703738;83993;84569;16719.910011248594;16823.32706691743;17056.829431705773;17165.227564759367;17363.82636173622;29239.269018274714;29461;29495.26261843471;29562;29582.668779904954;8320.583970801435;8326.79261507078;8415.53714545706;8630.956845215735;8860.335474839412;6912.654367281716;6964.825879353057;7058.752943646948;7086.185088714864;7090.645467726593;7911.248431399008;8594.441361311494;8614.138586141462;8694.348373683068;8715.825683486295;3228.4027454920915;3247.4966380211104;3302.8348582570775;3414.3171365726953;3416.350893330259;791.7189397763711;823.1521532821204;848.9448185867899;881.2861582118504;930.7812664023949;16695.415660451825;16789.832101679072;16893.408730694366;16937.576560586083;17742;377.5846568774326;387.44014898472;391.35817259694124;391.8569722051488;870.2515836380708;5200.6619569727845;5226.372835259793;5498.560115190775;5571.718504743932;5824.737886795105;397946;402074;415648;419537;428539;51769.741151294;70856;71662;78458;81359;383.2756090988035;399.5884239233594;401.45201799544;402.2819267607307;402.59136975969415;7332.963335183504;9141.680041198526;10131.898681013095;10545.630902918361;10609.9469502652;38158.61841381551;38362.42456363101;38875.61124388833;38944;40359.79820100998;48846;49182.508174919225;49368.75315623399;49394.50605493899;50082;7298.37963773064;7338.679037773252;7421.18366979621;7651.655675494505;7985.72049978248;10931.781364372828;10994.725131871448;11101.888981110409;11228.214025018171;11746.647600571996;9743.951280243553;9795.902040979785;9808.65669701557;9944.1547468466;10036.447995360326;9143.3599648024;9258.259339252978;9485;10016.048475394826;10117.140043096419;9649.035096490576;9746.26902982265;9928.851067234142;10021.09810117093;10295.94852025765;7211.2428195038765;7435.591042492499;7448.404127669665;7491.925080749123;7519.323260906544;7703.3067023968115;9057;9505.857412138961;9684.515774211402;9732.270079744188 11:56:31 INFO - PROCESS | 6582 | |3;mootools.html;1337.7658909690804;1375.5804479633712;1392.7701929181685;1640.6964711528376;1654.9007059576434;6785.796426107212;7012.929870701291;7014.438844892409;7605.16343202248;7658.38732901368;7404.444666649996;7638.236176382359;7642.694292228318;7701.114371847239;7791.883121753178;2090.498280412701;2116.8412369072303;2121.596896589651;2122.0875023739786;2124.2140408048967;1863.059155126659;2059.7116403703494;2108.652072408051;2125.1180759984586;2138.9786102139014;2148.366231961575;2156.4608847788054;2157.072458842697;2164.2425151197035;2167.436466518701;2102.7686954435;2119.34300366886;2163.707899433588;2173.3154056472163;2174.5430561523817;2104.6422108241636;2108.283183717528;2113.144176608476;2116.1112332820253;2160.3842904772064;7858.567778772165;7905.446618736691;7914.643841027168;7917.881231781528;7919.643616037292;4222.2188895054205;4222.2611043067645;4267.551907049746;4270.210011147917;4278.144371125756;2752.4357506711076;2900.5359142537304;2928.824270543774;2942.1320710390273;2948.3071478202605;884.3765145572356;897.5960817632026;924.8057907839362;933.0389698610375;937.3766445313926;10576.894231057668;10582.523786429552;10594.841077383846;10613.991670791262;10620.628278010232;3576.159602493412;3980.800959951991;3993.4608827808456;4078.408630748525;4089.325261331847;9035.63857445708;9036.32227582934;9038.81922361549;9038.954805225932;9045.502497362577;4331.5884990925815;4354.608085272341;4355.73865568067;4358.3244597087505;4365.694401391872;3949.3681011038097;3951.6245956634075;3952.051507638146;3953.327934251184;3958.524977002778;3392.2197894484407;3504.807235602015;3576.6780989710533;3598.820058997092;3604.6034936157002;1025.3079171559168;1087.0705546757567;1120.6077872744474;1126.9436528173558;1145.0496088246734;803.3171803966582;823.1069289820492;826.2439867521271;827.664795757707;830;4983.227599722049;5016.1723315653235;5106.412762532282;5157.587393008625;5258.7370631468275;804.5574933786511;815.4872711120786;827.995860020708;862.2799962031773;905.9852964679601;3332.500124981272;3332.7667063305335;3397.473391624302;3420.7605467617027;3500.1599616091953;9438.95280523593;9642.566084526214;9669.419834809934;9736.659216927515;9804.65683701067;8386.371022173362;8891.866622000674;9698.224142068617;9713.660021899199;9716.125548700651;7026.683799229047;7303.050603421521;7306.59813710251;7307.817304567428;7316.926830731837;5170.302009228856;5173.948260517347;5192.792288308426;5236.711980841091;5455.454454554671;8436.493810371398;8485.575721214038;8591.140885911358;8622.439541429787;8638.17937295956;8636.265917397091;8755.69355072595;8798;8901.154390332907;8901.287896968097;5939.46544810969;6109.816705498843;6187.84530386744;6264.812055638338;6316.14732011191;7179.784606461814;7243.058402407653;7249;7250.347468727839;7253.455990800606;6464.450521705708;6555.934440655723;6594.538382313192;6600.207975042834;6691.698873550605;6165.321814600301;6182.28903676083;6203.565750397429;6261.467775239155;6346.397092276226;6050.334463209131;6170.938290617037;6189.288231853395;6194.442500175006;6196.907046394217;4289.485261768607;4357.71674841147;4384.430024096847;4444.466664000341;4465.124647647931;4245.150969805989;4350.52144264137;4494;4507.4365704286965;4508.301213311811 11:56:31 INFO - PROCESS | 6582 | |4;prototype.html;287.1299961117812;288.3210040354964;291.32994113538854;300.3302635123674;301.19430523350036;4826.372571565696;4835.2505361669;4860.513948605138;4865.318855360252;4893.951060489394;4795.712257264567;4803.783829727662;4803.807847686088;4816.879578010551;4817.108834865552;3804.847806087767;3808.371618682928;3808.7905165215902;3809.5047643806265;3818.4081467372603;3647.270545890819;3817.656410923016;3820.7134464915102;3822.9426558601645;3827.5789663137034;3695.7043436525014;3721.641600815696;3758.229562939591;3761.9435708464393;3763.266163098197;3753.3244016077097;3759;3760.360738674432;3765.3975363941913;3779.79211143387;3120.641126270485;3250.983745081283;3272.6236482804543;3300.1584595928125;3310.7682462227654;4472.351509031205;4664.836730714443;4676.649251306131;4713.764311784432;4732.881677958044;4304.78476076195;4305.763183024932;4312.654987600984;4314.309710446313;4320.783960801948;4749.145153872301;5058.558310881418;5069.898602027975;5071.793769710188;5074.67014644047;3483.9548135559485;3491.598466176397;3501.7898926064518;3502.3713973002677;3516.6307537708426;5206.297149884755;5245.872137490496;5251.372074656869;5263.894722105537;5265.605079619044;3616.5660120785674;3621.8732344367822;3621.9818900905852;3627.510286111394;3628.385368510987;3411.8976430707116;3581.6955558777277;3606.585242697071;3678.1057755256065;3685.1708365618056;4143.254214241405;4143.440635514227;4156.8129434175535;4156.896077598024;4156.916861662749;4981.854173540106;4989.600831933437;4997.825076122318;5002.849914502498;5026.296318515338;1216.6069850021674;1245.4768997021272;1260.6785269756153;1264.7091169031175;1265.2471779291307;802.4102284820652;802.4182467710863;813.3777660090036;814.3810703865105;816.2368185746346;3892.279928213233;3923.8234279457492;3932.6853851691794;3967.206558688274;3971.4837071180564;4510.594046535827;4530.02604440047;4533.659975501851;4534.410526631583;4558.49856515783;3946;3947.230290093404;3966.591859889755;3968.2857085724845;4116.403121547419;2682.450097729961;2747.766439852595;2753.490604238222;2757.5036493431376;2758.3517873299757;4630.4443466784205;4757.381540399726;4856.757162141949;4863.586595139382;4875.195592727231;5283.471652834763;5293.258943747878;5312.920306195333;5326.973365133227;5344.4922732340365;4849.878753031202;4862.149123903374;4862.41651001882;4894.433781189985;4895.922896962663;4974.477679843564;5083.72039537829;5112.105381558138;5132.7433628317685;5146.816232266525;5062.468440813809;5074.340335756476;5075.822346217865;5102.948970510248;5108.591312694901;4759.690620109682;4871.171900776805;4891.682040667345;4919.852404427873;4922.876928076684;3652.2330310635066;3670.7614005089586;3686.834092465792;3689.4281386385155;3694.4273637586216;5146.948530514647;5176.844694659167;5180.704823794052;5190.97404512975;5199.740012999259;5004.099262132851;5025.874353141201;5038.269450929522;5056.974715126548;5067.0879241735365;4806.591439727662;4998.525140111684;4999.325091112799;5008.724520151427;5026.773795179299;4941.876453088702;4949.257611358325;4967.317648469931;4971.154903666457;4989.875253118701;5057.620678449058;5070.721110338966;5082.593392528663;5093.719845408538;5107.395228433451;4726.26742854858;4971;5009.348784657971;5009.448960614257;5012.072766538202 11:56:31 INFO - PROCESS | 6582 | |5;yui.html;555.7721334252957;579.3916387792816;590.0672020980168;618.5979113576175;687.88649872771;11720.355380454072;12360.876391236096;13110.147840390367;13529.12060716054;13533.255670938106;12497.43761530731;13163;13534.526291579798;13552.39014244359;13573.321333933289;617.1206031405229;735.746167572188;762.4281788658507;769.522895804602;769.6267310354474;747.1295940229626;768.108993567459;768.4313607930119;778.1246098139593;778.7469072551444;812.1999830167281;818.7543736878943;819.0499021135485;819.1439945257191;819.4468733604823;635.240887139868;807.8868958345836;809.8785182222714;810.7040930060544;811.6550466051934;575.1143239411301;590.2150140313415;590.822753174046;595.8272101090722;596.2010905386802;12772.61682149537;12796.680082997906;12804.61586152417;12810.743785124245;12822;11794.646160615195;11821.586244481488;12277.815832762515;12373.752524949541;13439.731205375936;9861.852072218922;9999;11691.356975366352;11747.47136378865;11853.170278080537;3089.7837151399413;3118.2549708067595;3174.873005079794;3210.085125739153;3280.1471617379416;68199.3180068198;68617.65691171562;69242.30757692459;69452.6527367365;70002.2999770006;10288.948555257175;10388.48057597117;10512.540022677485;10801.351918884735;10804.1896857736;18917.14872830726;18918.3378581749;19019.714704279446;19030.809691902905;19278.32525861588;6775.254721980578;6831.487638427137;6849.657517124124;6967.825804354931;7088.184858741311;3464.8094354810223;3504.369213541587;3534.5581802274714;3542.362374772514;3602.945955810665;2828.208101731477;2897.6590487342824;2940.1767505098605;2943.7644988401303;2949.483840327934;469.28199854223095;475.60999980016055;480.06147980697654;481.75912043978013;487.29829046174103;439.33660173138793;441.4966937691035;552.4972275229521;594.3343455330058;594.5332913662754;7175.282471752783;7493.288137626917;7825.604803460788;8200.917990820135;8381.235860222772;511.4501910446285;512.2546694559408;564.6442741073098;565.4402141879509;578.9937865296766;3672.8714494992546;3769.679577235911;3771.6228377162615;3817.9427308590393;3856.2094770571966;53543.73228133834;84207.5789621048;84278.57860710657;86216.56891715502;87796.56101719578;72685.2731472689;79723;80270.5986470064;90722;90866;45675.915141016594;46244.537554624694;50348.49651503511;84381.57809211037;85231.14768852232;8101.149379315087;8496.787580310542;8537.18896704812;8548.230659240699;8786.384953053224;44766.55233447754;46871.76564117157;47213.29180062233;47298.05403891972;47702.284465733734;53455.73272133614;58672;61631.38368616257;68715.65642171758;70159.29840701527;11064.723381915517;11170.441477926233;11394.316341019565;11414.543418263176;11700.824487632523;11871.525138994344;11930.22453540517;11972.102092342935;12756.553520626734;12779.23324600527;10876.12990960737;11034.393108378796;11077.446127693744;11601.825972610586;11639.41802909868;10914.290571112851;11017;11208.159388046091;11703.531858725555;11720.472578733807;10467.476626168813;10662.46687665598;10805.135589152691;11352.94323528377;12133.635990920286;9119.404104281857;9712.5143742814;10185.592576296865;10257.640982565574;10308.948455257676;9369.437833729999;9533.23734101284;9548.331616787036;9552.42685438876;9845.212383009486 11:56:31 INFO - PROCESS | 6582 | __end_tp_report 11:56:31 INFO - PROCESS | 6582 | __start_cc_report 11:56:31 INFO - PROCESS | 6582 | _x_x_mozilla_cycle_collect,964 11:56:31 INFO - PROCESS | 6582 | __end_cc_report 11:56:31 INFO - PROCESS | 6582 | __startTimestamp1471978591900__endTimestamp 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | ------- Summary: start ------- 11:56:31 INFO - PROCESS | 6582 | Number of tests: 6 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#0] dojo.html Cycles:165 Average:4669.37 Median:4785.23 stddev:484.30 (10.1%) stddev-sans-first:457.88 11:56:31 INFO - PROCESS | 6582 | Values: 2603.8 2646.3 2650.8 2659.7 2673.8 4657.0 4666.7 4714.9 4756.4 4778.3 4668.7 4714.4 4726.6 4760.7 4856.4 4139.4 4365.0 4416.2 4429.6 4434.5 4414.1 4438.6 4451.6 4465.1 4478.4 4203.5 4279.2 4316.3 4331.0 4354.3 4390.0 4391.7 4393.1 4395.5 4400.8 4352.6 4363.9 4386.2 4391.8 4394.1 4611.8 4659.1 4700.1 4708.5 4775.2 5092.8 5101.5 5109.2 5110.5 5122.7 5142.3 5149.5 5153.4 5157.5 5168.1 4626.3 4657.8 4694.2 4701.3 4787.1 5169.5 5190.3 5194.8 5197.6 5202.7 4995.8 4998.9 5002.4 5004.7 5012.0 4861.8 4885.9 4913.0 4918.1 5065.1 4945.9 4950.5 4950.6 4951.3 4952.2 4936.9 4944.9 4949.6 4951.4 4952.6 4166.8 4206.9 4209.5 4247.3 4294.7 3710.1 3753.1 3780.6 3791.1 3810.3 4375.6 4377.3 4385.7 4386.3 4390.8 4779.7 5091.8 5130.0 5139.3 5146.1 4282.8 4324.5 4336.1 4375.0 4389.9 4591.7 4600.5 4602.3 4604.0 4607.0 4588.6 4756.6 4795.1 4802.9 4808.7 4928.9 4969.2 4984.2 5089.0 5090.0 4783.4 4785.2 4792.9 4793.4 4799.1 4765.0 5019.3 5026.8 5034.6 5035.0 4971.4 5000.2 5031.3 5080.5 5101.6 4960.7 4965.8 4966.5 4975.8 4976.7 4786.9 4952.1 4962.5 4968.5 4969.0 4760.5 4783.7 4808.8 4845.8 4869.6 4947.6 4991.8 4992.1 4992.4 4993.8 4663.5 4696.3 4872.0 4891.5 4893.6 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#1] ext.html Cycles:180 Average:46042.40 Median:212793.00 stddev:83399.79 (39.2%) stddev-sans-first:83563.82 11:56:31 INFO - PROCESS | 6582 | Values: 553.3 554.9 555.0 562.3 563.5 37890.0 39370.8 39593.4 43934.1 44090.0 40760.2 41217.6 41252.0 41283.4 41371.8 7721.2 7867.4 7910.8 7918.2 7925.9 7653.9 7740.6 7745.3 7745.9 7747.1 7706.8 7725.7 7747.6 7759.7 7763.0 7688.6 7693.2 7719.2 7722.5 7727.4 7600.8 7652.5 7670.5 7673.3 7673.5 38875.2 38980.4 39243.8 39246.0 39295.4 2843.7 2993.4 3058.6 3331.5 3348.3 28880.4 29116.6 29216.3 29464.7 29999.6 2927.3 3034.5 3066.4 3092.8 3112.8 260860.0 262109.7 262196.0 262329.0 262786.0 53054.7 53289.2 53346.5 53413.0 53425.1 32576.8 33442.5 33479.8 35268.0 56293.0 13737.9 13816.4 13877.3 13893.0 13959.1 9681.8 9705.9 9736.6 9765.2 9788.5 17987.0 18228.1 18235.3 18293.7 18347.8 6625.7 6719.3 7015.6 7015.9 7016.8 733.6 913.2 951.0 983.2 1015.1 27529.2 28080.4 28109.3 28170.9 28943.3 868.9 923.6 956.4 966.6 996.2 14203.9 14702.9 15043.2 15169.5 15513.8 387696.0 389435.0 391856.0 392830.0 393892.0 49363.5 49457.3 49674.0 49680.0 49786.8 1019.6 1090.7 1165.2 1173.8 1201.3 25596.7 28879.4 29516.6 29596.2 29976.7 41867.0 42325.6 42515.4 42523.0 42591.4 280121.0 281727.0 281823.0 282252.0 282377.0 22539.3 24660.9 25686.0 25852.1 26045.7 38771.2 39047.8 39337.8 39743.6 40360.2 33303.5 33392.5 33445.5 33870.5 34313.0 33554.5 33628.7 33644.3 33914.0 34201.1 32855.2 33709.7 33735.8 34210.1 34318.3 28097.2 30433.2 30535.5 30768.8 30777.5 23453.8 23666.9 23895.3 24261.0 24320.9 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#2] jquery.html Cycles:180 Average:25871.07 Median:49381.63 stddev:68046.19 (137.8%) stddev-sans-first:68210.06 11:56:31 INFO - PROCESS | 6582 | Values: 336.4 356.2 357.7 358.2 382.6 12783.7 16099.4 16341.3 17633.8 17815.4 15302.6 15806.3 15929.8 16172.3 16296.1 4940.9 5161.5 6567.1 6861.6 6920.9 4047.6 5350.6 6857.4 7026.1 7030.2 7005.5 7121.4 7124.1 7132.3 7136.0 6777.2 6836.5 6841.0 6888.4 7099.4 6478.0 6644.8 6657.9 6660.1 6665.4 23408.6 23873.2 24149.2 24171.4 24527.8 1836.7 1934.7 1993.3 2026.7 2034.7 13801.3 13935.7 14561.3 14910.6 15390.3 1819.3 1884.7 1890.8 1912.2 1933.5 67284.0 80656.6 81486.6 83993.0 84569.0 16719.9 16823.3 17056.8 17165.2 17363.8 29239.3 29461.0 29495.3 29562.0 29582.7 8320.6 8326.8 8415.5 8631.0 8860.3 6912.7 6964.8 7058.8 7086.2 7090.6 7911.2 8594.4 8614.1 8694.3 8715.8 3228.4 3247.5 3302.8 3414.3 3416.4 791.7 823.2 848.9 881.3 930.8 16695.4 16789.8 16893.4 16937.6 17742.0 377.6 387.4 391.4 391.9 870.3 5200.7 5226.4 5498.6 5571.7 5824.7 397946.0 402074.0 415648.0 419537.0 428539.0 51769.7 70856.0 71662.0 78458.0 81359.0 383.3 399.6 401.5 402.3 402.6 7333.0 9141.7 10131.9 10545.6 10609.9 38158.6 38362.4 38875.6 38944.0 40359.8 48846.0 49182.5 49368.8 49394.5 50082.0 7298.4 7338.7 7421.2 7651.7 7985.7 10931.8 10994.7 11101.9 11228.2 11746.6 9744.0 9795.9 9808.7 9944.2 10036.4 9143.4 9258.3 9485.0 10016.0 10117.1 9649.0 9746.3 9928.9 10021.1 10295.9 7211.2 7435.6 7448.4 7491.9 7519.3 7703.3 9057.0 9505.9 9684.5 9732.3 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#3] mootools.html Cycles:180 Average:4987.75 Median:5183.37 stddev:2826.71 (54.5%) stddev-sans-first:2821.33 11:56:31 INFO - PROCESS | 6582 | Values: 1337.8 1375.6 1392.8 1640.7 1654.9 6785.8 7012.9 7014.4 7605.2 7658.4 7404.4 7638.2 7642.7 7701.1 7791.9 2090.5 2116.8 2121.6 2122.1 2124.2 1863.1 2059.7 2108.7 2125.1 2139.0 2148.4 2156.5 2157.1 2164.2 2167.4 2102.8 2119.3 2163.7 2173.3 2174.5 2104.6 2108.3 2113.1 2116.1 2160.4 7858.6 7905.4 7914.6 7917.9 7919.6 4222.2 4222.3 4267.6 4270.2 4278.1 2752.4 2900.5 2928.8 2942.1 2948.3 884.4 897.6 924.8 933.0 937.4 10576.9 10582.5 10594.8 10614.0 10620.6 3576.2 3980.8 3993.5 4078.4 4089.3 9035.6 9036.3 9038.8 9039.0 9045.5 4331.6 4354.6 4355.7 4358.3 4365.7 3949.4 3951.6 3952.1 3953.3 3958.5 3392.2 3504.8 3576.7 3598.8 3604.6 1025.3 1087.1 1120.6 1126.9 1145.0 803.3 823.1 826.2 827.7 830.0 4983.2 5016.2 5106.4 5157.6 5258.7 804.6 815.5 828.0 862.3 906.0 3332.5 3332.8 3397.5 3420.8 3500.2 9439.0 9642.6 9669.4 9736.7 9804.7 8386.4 8891.9 9698.2 9713.7 9716.1 7026.7 7303.1 7306.6 7307.8 7316.9 5170.3 5173.9 5192.8 5236.7 5455.5 8436.5 8485.6 8591.1 8622.4 8638.2 8636.3 8755.7 8798.0 8901.2 8901.3 5939.5 6109.8 6187.8 6264.8 6316.1 7179.8 7243.1 7249.0 7250.3 7253.5 6464.5 6555.9 6594.5 6600.2 6691.7 6165.3 6182.3 6203.6 6261.5 6346.4 6050.3 6170.9 6189.3 6194.4 6196.9 4289.5 4357.7 4384.4 4444.5 4465.1 4245.2 4350.5 4494.0 4507.4 4508.3 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#4] prototype.html Cycles:180 Average:4126.02 Median:4729.57 stddev:1210.26 (25.6%) stddev-sans-first:1178.85 11:56:31 INFO - PROCESS | 6582 | Values: 287.1 288.3 291.3 300.3 301.2 4826.4 4835.3 4860.5 4865.3 4894.0 4795.7 4803.8 4803.8 4816.9 4817.1 3804.8 3808.4 3808.8 3809.5 3818.4 3647.3 3817.7 3820.7 3822.9 3827.6 3695.7 3721.6 3758.2 3761.9 3763.3 3753.3 3759.0 3760.4 3765.4 3779.8 3120.6 3251.0 3272.6 3300.2 3310.8 4472.4 4664.8 4676.6 4713.8 4732.9 4304.8 4305.8 4312.7 4314.3 4320.8 4749.1 5058.6 5069.9 5071.8 5074.7 3484.0 3491.6 3501.8 3502.4 3516.6 5206.3 5245.9 5251.4 5263.9 5265.6 3616.6 3621.9 3622.0 3627.5 3628.4 3411.9 3581.7 3606.6 3678.1 3685.2 4143.3 4143.4 4156.8 4156.9 4156.9 4981.9 4989.6 4997.8 5002.8 5026.3 1216.6 1245.5 1260.7 1264.7 1265.2 802.4 802.4 813.4 814.4 816.2 3892.3 3923.8 3932.7 3967.2 3971.5 4510.6 4530.0 4533.7 4534.4 4558.5 3946.0 3947.2 3966.6 3968.3 4116.4 2682.5 2747.8 2753.5 2757.5 2758.4 4630.4 4757.4 4856.8 4863.6 4875.2 5283.5 5293.3 5312.9 5327.0 5344.5 4849.9 4862.1 4862.4 4894.4 4895.9 4974.5 5083.7 5112.1 5132.7 5146.8 5062.5 5074.3 5075.8 5102.9 5108.6 4759.7 4871.2 4891.7 4919.9 4922.9 3652.2 3670.8 3686.8 3689.4 3694.4 5146.9 5176.8 5180.7 5191.0 5199.7 5004.1 5025.9 5038.3 5057.0 5067.1 4806.6 4998.5 4999.3 5008.7 5026.8 4941.9 4949.3 4967.3 4971.2 4989.9 5057.6 5070.7 5082.6 5093.7 5107.4 4726.3 4971.0 5009.3 5009.4 5012.1 11:56:31 INFO - PROCESS | 6582 | 11:56:31 INFO - PROCESS | 6582 | [#5] yui.html Cycles:180 Average:17052.84 Median:24088.95 stddev:23847.42 (99.0%) stddev-sans-first:23882.15 11:56:31 INFO - PROCESS | 6582 | Values: 555.8 579.4 590.1 618.6 687.9 11720.4 12360.9 13110.1 13529.1 13533.3 12497.4 13163.0 13534.5 13552.4 13573.3 617.1 735.7 762.4 769.5 769.6 747.1 768.1 768.4 778.1 778.7 812.2 818.8 819.0 819.1 819.4 635.2 807.9 809.9 810.7 811.7 575.1 590.2 590.8 595.8 596.2 12772.6 12796.7 12804.6 12810.7 12822.0 11794.6 11821.6 12277.8 12373.8 13439.7 9861.9 9999.0 11691.4 11747.5 11853.2 3089.8 3118.3 3174.9 3210.1 3280.1 68199.3 68617.7 69242.3 69452.7 70002.3 10288.9 10388.5 10512.5 10801.4 10804.2 18917.1 18918.3 19019.7 19030.8 19278.3 6775.3 6831.5 6849.7 6967.8 7088.2 3464.8 3504.4 3534.6 3542.4 3602.9 2828.2 2897.7 2940.2 2943.8 2949.5 469.3 475.6 480.1 481.8 487.3 439.3 441.5 552.5 594.3 594.5 7175.3 7493.3 7825.6 8200.9 8381.2 511.5 512.3 564.6 565.4 579.0 3672.9 3769.7 3771.6 3817.9 3856.2 53543.7 84207.6 84278.6 86216.6 87796.6 72685.3 79723.0 80270.6 90722.0 90866.0 45675.9 46244.5 50348.5 84381.6 85231.1 8101.1 8496.8 8537.2 8548.2 8786.4 44766.6 46871.8 47213.3 47298.1 47702.3 53455.7 58672.0 61631.4 68715.7 70159.3 11064.7 11170.4 11394.3 11414.5 11700.8 11871.5 11930.2 11972.1 12756.6 12779.2 10876.1 11034.4 11077.4 11601.8 11639.4 10914.3 11017.0 11208.2 11703.5 11720.5 10467.5 10662.5 10805.1 11352.9 12133.6 9119.4 9712.5 10185.6 10257.6 10308.9 9369.4 9533.2 9548.3 9552.4 9845.2 11:56:31 INFO - PROCESS | 6582 | -------- Summary: end -------- 11:56:31 INFO - PROCESS | 6582 | 11:56:32 INFO - TEST-INFO | 6582: exit 0 11:56:32 INFO - TEST-OK | dromaeo_css | took 1122073ms 11:56:32 INFO - TEST-START | kraken 11:56:32 INFO - operating with platform_type : linux_ 11:56:32 INFO - Initialising browser for kraken test... 11:56:32 INFO - TEST-INFO | started process 6887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cgtmW/profile http://localhost:35658/getInfo.html) 11:56:37 INFO - PROCESS | 6887 | __metrics Screen width/height:1600/1200 11:56:37 INFO - PROCESS | 6887 | colorDepth:24 11:56:37 INFO - PROCESS | 6887 | Browser inner width/height: 1024/697 11:56:37 INFO - PROCESS | 6887 | __metrics 11:56:37 INFO - PROCESS | 6887 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:56:37 INFO - PROCESS | 6887 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:38 INFO - PROCESS | 6887 | console.error: PushService: 11:56:38 INFO - PROCESS | 6887 | stateChangeProcessEnqueue: Error transitioning state 11:56:38 INFO - PROCESS | 6887 | UnknownError 11:56:39 INFO - TEST-INFO | 6887: exit 0 11:56:39 INFO - Browser initialized. 11:56:39 INFO - Running cycle 1/1 for kraken test... 11:56:39 INFO - TEST-INFO | started process 6971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cgtmW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:51 INFO - PROCESS | 6971 | RSS: Main: 176087040 11:56:51 INFO - PROCESS | 6971 | 11:56:54 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection) 11:56:55 INFO - PROCESS | 6971 | RSS: Main: 244965376 11:56:55 INFO - PROCESS | 6971 | 11:56:57 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-dft) 11:56:58 INFO - PROCESS | 6971 | RSS: Main: 227315712 11:56:58 INFO - PROCESS | 6971 | 11:57:01 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-fft) 11:57:02 INFO - PROCESS | 6971 | RSS: Main: 302870528 11:57:02 INFO - PROCESS | 6971 | 11:57:04 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator) 11:57:05 INFO - PROCESS | 6971 | RSS: Main: 210481152 11:57:05 INFO - PROCESS | 6971 | 11:57:07 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:08 INFO - PROCESS | 6971 | RSS: Main: 215138304 11:57:08 INFO - PROCESS | 6971 | 11:57:11 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:11 INFO - PROCESS | 6971 | RSS: Main: 250912768 11:57:11 INFO - PROCESS | 6971 | 11:57:15 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:16 INFO - PROCESS | 6971 | RSS: Main: 244383744 11:57:16 INFO - PROCESS | 6971 | 11:57:18 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial) 11:57:19 INFO - PROCESS | 6971 | RSS: Main: 248287232 11:57:19 INFO - PROCESS | 6971 | 11:57:21 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:21 INFO - PROCESS | 6971 | RSS: Main: 211914752 11:57:21 INFO - PROCESS | 6971 | 11:57:23 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:24 INFO - PROCESS | 6971 | RSS: Main: 218497024 11:57:24 INFO - PROCESS | 6971 | 11:57:26 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:27 INFO - PROCESS | 6971 | RSS: Main: 223645696 11:57:27 INFO - PROCESS | 6971 | 11:57:30 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:30 INFO - PROCESS | 6971 | RSS: Main: 218898432 11:57:30 INFO - PROCESS | 6971 | 11:57:33 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:34 INFO - PROCESS | 6971 | RSS: Main: 221274112 11:57:34 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | Cycle 1(1): loaded http://localhost:35658/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35658/tests/kraken/driver.html?testName=ai-astar) 11:57:36 INFO - PROCESS | 6971 | RSS: Main: 273526784 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | __start_tp_report 11:57:36 INFO - PROCESS | 6971 | _x_x_mozilla_page_load 11:57:36 INFO - PROCESS | 6971 | _x_x_mozilla_page_load_details 11:57:36 INFO - PROCESS | 6971 | |i|pagename|runs| 11:57:36 INFO - PROCESS | 6971 | |0;ai-astar;102;116;110;116;116;117;122;113;116;115 11:57:36 INFO - PROCESS | 6971 | |1;audio-beat-detection;155;123;151;190;123;151;154;133;192;137 11:57:36 INFO - PROCESS | 6971 | |2;audio-dft;162;163;161;162;160;161;161;161;160;161 11:57:36 INFO - PROCESS | 6971 | |3;audio-fft;76;76;76;179;79;77;77;109;109;77 11:57:36 INFO - PROCESS | 6971 | |4;audio-oscillator;88;87;151;87;86;88;141;86;85;133 11:57:36 INFO - PROCESS | 6971 | |5;imaging-gaussian-blur;117;117;116;117;118;117;117;117;117;117 11:57:36 INFO - PROCESS | 6971 | |6;imaging-darkroom;147;148;147;148;148;148;149;147;148;147 11:57:36 INFO - PROCESS | 6971 | |7;imaging-desaturate;95;94;95;95;94;94;95;95;95;95 11:57:36 INFO - PROCESS | 6971 | |8;json-parse-financial;64;64;67;66;67;65;66;65;65;66 11:57:36 INFO - PROCESS | 6971 | |9;json-stringify-tinderbox;66;67;67;67;67;66;67;67;67;68 11:57:36 INFO - PROCESS | 6971 | |10;stanford-crypto-aes;92;83;83;83;87;82;81;83;83;82 11:57:36 INFO - PROCESS | 6971 | |11;stanford-crypto-ccm;132;133;144;139;132;132;136;140;164;146 11:57:36 INFO - PROCESS | 6971 | |12;stanford-crypto-pbkdf2;173;175;174;171;175;173;174;176;171;168 11:57:36 INFO - PROCESS | 6971 | |13;stanford-crypto-sha256-iterative;72;68;68;69;67;70;69;69;67;68 11:57:36 INFO - PROCESS | 6971 | __end_tp_report 11:57:36 INFO - PROCESS | 6971 | __start_cc_report 11:57:36 INFO - PROCESS | 6971 | _x_x_mozilla_cycle_collect,2020 11:57:36 INFO - PROCESS | 6971 | __end_cc_report 11:57:36 INFO - PROCESS | 6971 | __startTimestamp1471978656516__endTimestamp 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | ------- Summary: start ------- 11:57:36 INFO - PROCESS | 6971 | Number of tests: 14 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.00 stddev:5.27 (4.5%) stddev-sans-first:3.20 11:57:36 INFO - PROCESS | 6971 | Values: 102.0 116.0 110.0 116.0 116.0 117.0 122.0 113.0 116.0 115.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:152.50 stddev:24.30 (15.9%) stddev-sans-first:25.73 11:57:36 INFO - PROCESS | 6971 | Values: 155.0 123.0 151.0 190.0 123.0 151.0 154.0 133.0 192.0 137.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 11:57:36 INFO - PROCESS | 6971 | Values: 162.0 163.0 161.0 162.0 160.0 161.0 161.0 161.0 160.0 161.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:32.89 (43.0%) stddev-sans-first:34.27 11:57:36 INFO - PROCESS | 6971 | Values: 76.0 76.0 76.0 179.0 79.0 77.0 77.0 109.0 109.0 77.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.50 stddev:26.90 (31.1%) stddev-sans-first:27.96 11:57:36 INFO - PROCESS | 6971 | Values: 88.0 87.0 151.0 87.0 86.0 88.0 141.0 86.0 85.0 133.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:57:36 INFO - PROCESS | 6971 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:57:36 INFO - PROCESS | 6971 | Values: 147.0 148.0 147.0 148.0 148.0 148.0 149.0 147.0 148.0 147.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:57:36 INFO - PROCESS | 6971 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 11:57:36 INFO - PROCESS | 6971 | Values: 64.0 64.0 67.0 66.0 67.0 65.0 66.0 65.0 65.0 66.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 11:57:36 INFO - PROCESS | 6971 | Values: 66.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 68.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.25 (3.9%) stddev-sans-first:1.66 11:57:36 INFO - PROCESS | 6971 | Values: 92.0 83.0 83.0 83.0 87.0 82.0 81.0 83.0 83.0 82.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.50 stddev:9.92 (7.1%) stddev-sans-first:10.11 11:57:36 INFO - PROCESS | 6971 | Values: 132.0 133.0 144.0 139.0 132.0 132.0 136.0 140.0 164.0 146.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:174.00 stddev:2.40 (1.4%) stddev-sans-first:2.55 11:57:36 INFO - PROCESS | 6971 | Values: 173.0 175.0 174.0 171.0 175.0 173.0 174.0 176.0 171.0 168.0 11:57:36 INFO - PROCESS | 6971 | 11:57:36 INFO - PROCESS | 6971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.00 11:57:36 INFO - PROCESS | 6971 | Values: 72.0 68.0 68.0 69.0 67.0 70.0 69.0 69.0 67.0 68.0 11:57:36 INFO - PROCESS | 6971 | -------- Summary: end -------- 11:57:36 INFO - PROCESS | 6971 | 11:57:37 INFO - TEST-INFO | 6971: exit 0 11:57:37 INFO - TEST-OK | kraken | took 64953ms 11:57:37 INFO - SUITE-END | took 1187s 11:57:38 INFO - Completed test suite (00:19:47) 11:57:38 INFO - javascript benchmark 11:57:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.8437693738374, 2646.2722751243414, 2650.814442988989, 2659.6542449481576, 2673.78609711223, 4657.0453057123295, 4666.743329116897, 4714.858554243369, 4756.429228492581, 4778.331033655287, 4668.719876807386, 4714.363560919283, 4726.645501587377, 4760.714357138574, 4856.417229932405, 4139.3583994480905, 4364.956350436502, 4416.1609294233995, 4429.64562834974, 4434.49003364614, 4414.05097903949, 4438.600525952664, 4451.577100175478, 4465.106978604276, 4478.350639157336, 4203.516595591515, 4279.186954478639, 4316.309390497506, 4330.9605694633065, 4354.281543545311, 4390.034192477649, 4391.714538555016, 4393.143337049277, 4395.4725432947935, 4400.823967041314, 4352.586504282088, 4363.890902727458, 4386.166628340605, 4391.824327026915, 4394.099209662011, 4611.792469338888, 4659.091477161955, 4700.130475861943, 4708.529147085298, 4775.2359622460235, 5092.796288148506, 5101.464346243628, 5109.233614957749, 5110.488951104897, 5122.718250496221, 5142.254373115915, 5149.485051494858, 5153.407358153823, 5157.53582177602, 5168.069747445458, 4626.306054091846, 4657.813687452532, 4694.248920172756, 4701.341812146234, 4787.090452813989, 5169.53474187325, 5190.325257716473, 5194.792208311701, 5197.636165468381, 5202.661826981234, 4995.825146119941, 4998.850034498971, 5002.374703162105, 5004.699718016931, 5011.974940125276, 4861.756912154378, 4885.877853053702, 4912.975435122801, 4918.0901533216465, 5065.138926382524, 4945.876353091202, 4950.529699678525, 4950.579200767903, 4951.257311403247, 4952.232403977389, 4936.8765780855765, 4944.90110197794, 4949.554540091409, 4951.430585482715, 4952.579030782424, 4166.812493437742, 4206.85276015338, 4209.515905670887, 4247.256730072225, 4294.742315461082, 3710.1466662667735, 3753.0992561784974, 3780.640839120279, 3791.1469919268498, 3810.333191691443, 4375.584319489643, 4377.299632058919, 4385.693001489929, 4386.298192289219, 4390.7705842364185, 4779.737114458669, 5091.803426194841, 5130.0, 5139.306193663882, 5146.125158723026, 4282.785860706952, 4324.459442569679, 4336.089421221515, 4375.0, 4389.868303950887, 4591.678582499259, 4600.53994600544, 4602.286645569942, 4603.95396046042, 4606.976965115153, 4588.609968152745, 4756.643251756063, 4795.064962332312, 4802.943352462453, 4808.734435792801, 4928.8767780805765, 4969.229769385751, 4984.17761069434, 5088.974555127201, 5089.999999999852, 4783.402074740658, 4785.234362501983, 4792.928106078341, 4793.424789025339, 4799.136155492045, 4764.952350476589, 5019.272205530251, 5026.773795179299, 5034.622403319839, 5034.974825125851, 4971.37857767779, 5000.199968005102, 5031.345925029723, 5080.517350851663, 5101.566366858859, 4960.70235785854, 4965.82619608312, 4966.528179822911, 4975.800967961241, 4976.651634385558, 4786.856394308176, 4952.083864485082, 4962.528559786959, 4968.453470118357, 4968.975155124202, 4760.476347601831, 4783.7129772213775, 4808.831690890802, 4845.8061677533915, 4869.561739443326, 4947.554720075211, 4991.750412479289, 4992.101421744121, 4992.350994370709, 4993.825216117564, 4663.510331415288, 4696.272077827942, 4871.975640121776, 4891.51084891508, 4893.6085113191575], "value": 4638.845996422122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3056014701549, 554.947280008399, 554.9539118761136, 562.2718579439626, 563.5322682173796, 37890.0, 39370.80314598427, 39593.406098908505, 43934.12131757363, 44090.0, 40760.18479630406, 41217.58782412175, 41252.0, 41283.380749288786, 41371.79314103425, 7721.189275126129, 7867.370610351187, 7910.7626771196665, 7918.208179182093, 7925.920740792576, 7653.885191722128, 7740.574268415235, 7745.3029227369525, 7745.883811742829, 7747.109082455533, 7706.845863082735, 7725.690972361127, 7747.573883436408, 7759.728409505668, 7762.961185194066, 7688.615569221544, 7693.153753087156, 7719.150893401749, 7722.53664780115, 7727.420443466706, 7600.8479830403085, 7652.464327497078, 7670.463067585271, 7673.271039251262, 7673.46285759997, 38875.22249555022, 38980.41529377033, 39243.80378098091, 39246.0, 39295.41056884149, 2843.6587609486787, 2993.3724597756295, 3058.602381690366, 3331.4503106987318, 3348.3303339332233, 28880.42239155226, 29116.563251551244, 29216.26959326034, 29464.70535294641, 29999.550006749916, 2927.34134819666, 3034.544818277254, 3066.4480393529157, 3092.752579793611, 3112.828794416306, 260860.0, 262109.72067374105, 262196.0, 262329.0, 262786.0, 53054.7347263269, 53289.2006619901, 53346.46653533415, 53413.0, 53425.11635347473, 32576.837115814742, 33442.49836252458, 33479.832600837326, 35268.0, 56293.0, 13737.931310343385, 13816.37826297819, 13877.306134693225, 13893.0, 13959.092658977133, 9681.806363872824, 9705.902940970642, 9736.610535578639, 9765.218782497383, 9788.510574471391, 17987.0, 18228.088595570167, 18235.270589176285, 18293.7255941161, 18347.81652183461, 6625.701843417058, 6719.260881303053, 7015.579065256101, 7015.859682806417, 7016.789496315118, 733.611186071383, 913.159892898535, 950.9714708558754, 983.2085171437062, 1015.0914931136591, 27529.174124776287, 28080.438391232063, 28109.297267568476, 28170.85914570414, 28943.276418089295, 868.917452841979, 923.5890028937058, 956.4357029352576, 966.5940305071887, 996.1881066930429, 14203.857961420461, 14702.926485367505, 15043.247837608076, 15169.469068582546, 15513.844861551466, 387696.0, 389435.0, 391856.0, 392830.0, 393892.0, 49363.506364936606, 49457.25814112791, 49674.0, 49680.0, 49786.75106624444, 1019.5870672377699, 1090.6782499162766, 1165.2018367418345, 1173.8004539228352, 1201.297241113958, 25596.744032559436, 28879.42241155207, 29516.557251640814, 29596.16181485009, 29976.700232998264, 41867.0, 42325.57674423217, 42515.3622695666, 42523.0, 42591.36112958246, 280121.0, 281727.0, 281823.0, 282252.0, 282377.0, 22539.32382028542, 24660.876695616407, 25686.0, 25852.095176668725, 26045.739542604333, 38771.22457550777, 39047.80476097715, 39337.80331098326, 39743.60256397399, 40360.1927961445, 33303.50044749379, 33392.49911251284, 33445.498317525744, 33870.491942620385, 34313.0, 33554.49668255027, 33628.663713362555, 33644.32711345809, 33914.0, 34201.06687730943, 32855.17862053468, 33709.66290337163, 33735.83132084324, 34210.14474638154, 34318.313633726684, 28097.157085287476, 30433.239169020067, 30535.54196687007, 30768.846280727754, 30777.538336924517, 23453.76546234516, 23666.88166559225, 23895.283141505784, 24261.0, 24320.87839560791], "value": 16987.167445307772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.35252139631234, 356.23942881947045, 357.71382893685063, 358.1887025886367, 382.5619665483022, 12783.680407989805, 16099.436519721812, 16341.264643091075, 17633.823661763377, 17815.37646182384, 15302.617434564141, 15806.288717007734, 15929.769832223468, 16172.27224774885, 16296.103714295708, 4940.901181976367, 5161.458046905077, 6567.146270984766, 6861.622610756406, 6920.930790692104, 4047.615476529725, 5350.635587925074, 6857.3828355448, 7026.1217347831525, 7030.242439390153, 7005.509614326999, 7121.394681452057, 7124.109486314211, 7132.286771322878, 7135.964320178417, 6777.186737591521, 6836.4530837533375, 6841.0, 6888.4144847688, 7099.396551293146, 6477.967610161966, 6644.767433139817, 6657.933420665829, 6660.134182556285, 6665.366790154928, 23408.64887026696, 23873.16443924454, 24149.15477958263, 24171.395715107086, 24527.754722452904, 1836.7244913263116, 1934.6904495280687, 1993.2824183294003, 2026.6554685703318, 2034.6947957806299, 13801.309934503235, 13935.651608709763, 14561.344739486749, 14910.62723431912, 15390.3074361654, 1819.2631984046482, 1884.679604467244, 1890.7920128785822, 1912.177763561668, 1933.497290704413, 67284.0, 80656.59671701663, 81486.59256703738, 83993.0, 84569.0, 16719.910011248594, 16823.32706691743, 17056.829431705773, 17165.227564759367, 17363.82636173622, 29239.269018274714, 29461.0, 29495.26261843471, 29562.0, 29582.668779904954, 8320.583970801435, 8326.79261507078, 8415.53714545706, 8630.956845215735, 8860.335474839412, 6912.654367281716, 6964.825879353057, 7058.752943646948, 7086.185088714864, 7090.645467726593, 7911.248431399008, 8594.441361311494, 8614.138586141462, 8694.348373683068, 8715.825683486295, 3228.4027454920915, 3247.4966380211104, 3302.8348582570775, 3414.3171365726953, 3416.350893330259, 791.7189397763711, 823.1521532821204, 848.9448185867899, 881.2861582118504, 930.7812664023949, 16695.415660451825, 16789.832101679072, 16893.408730694366, 16937.576560586083, 17742.0, 377.5846568774326, 387.44014898472, 391.35817259694124, 391.8569722051488, 870.2515836380708, 5200.6619569727845, 5226.372835259793, 5498.560115190775, 5571.718504743932, 5824.737886795105, 397946.0, 402074.0, 415648.0, 419537.0, 428539.0, 51769.741151294, 70856.0, 71662.0, 78458.0, 81359.0, 383.2756090988035, 399.5884239233594, 401.45201799544, 402.2819267607307, 402.59136975969415, 7332.963335183504, 9141.680041198526, 10131.898681013095, 10545.630902918361, 10609.9469502652, 38158.61841381551, 38362.42456363101, 38875.61124388833, 38944.0, 40359.79820100998, 48846.0, 49182.508174919225, 49368.75315623399, 49394.50605493899, 50082.0, 7298.37963773064, 7338.679037773252, 7421.18366979621, 7651.655675494505, 7985.72049978248, 10931.781364372828, 10994.725131871448, 11101.888981110409, 11228.214025018171, 11746.647600571996, 9743.951280243553, 9795.902040979785, 9808.65669701557, 9944.1547468466, 10036.447995360326, 9143.3599648024, 9258.259339252978, 9485.0, 10016.048475394826, 10117.140043096419, 9649.035096490576, 9746.26902982265, 9928.851067234142, 10021.09810117093, 10295.94852025765, 7211.2428195038765, 7435.591042492499, 7448.404127669665, 7491.925080749123, 7519.323260906544, 7703.3067023968115, 9057.0, 9505.857412138961, 9684.515774211402, 9732.270079744188], "value": 8594.310919448137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7658909690804, 1375.5804479633712, 1392.7701929181685, 1640.6964711528376, 1654.9007059576434, 6785.796426107212, 7012.929870701291, 7014.438844892409, 7605.16343202248, 7658.38732901368, 7404.444666649996, 7638.236176382359, 7642.694292228318, 7701.114371847239, 7791.883121753178, 2090.498280412701, 2116.8412369072303, 2121.596896589651, 2122.0875023739786, 2124.2140408048967, 1863.059155126659, 2059.7116403703494, 2108.652072408051, 2125.1180759984586, 2138.9786102139014, 2148.366231961575, 2156.4608847788054, 2157.072458842697, 2164.2425151197035, 2167.436466518701, 2102.7686954435, 2119.34300366886, 2163.707899433588, 2173.3154056472163, 2174.5430561523817, 2104.6422108241636, 2108.283183717528, 2113.144176608476, 2116.1112332820253, 2160.3842904772064, 7858.567778772165, 7905.446618736691, 7914.643841027168, 7917.881231781528, 7919.643616037292, 4222.2188895054205, 4222.2611043067645, 4267.551907049746, 4270.210011147917, 4278.144371125756, 2752.4357506711076, 2900.5359142537304, 2928.824270543774, 2942.1320710390273, 2948.3071478202605, 884.3765145572356, 897.5960817632026, 924.8057907839362, 933.0389698610375, 937.3766445313926, 10576.894231057668, 10582.523786429552, 10594.841077383846, 10613.991670791262, 10620.628278010232, 3576.159602493412, 3980.800959951991, 3993.4608827808456, 4078.408630748525, 4089.325261331847, 9035.63857445708, 9036.32227582934, 9038.81922361549, 9038.954805225932, 9045.502497362577, 4331.5884990925815, 4354.608085272341, 4355.73865568067, 4358.3244597087505, 4365.694401391872, 3949.3681011038097, 3951.6245956634075, 3952.051507638146, 3953.327934251184, 3958.524977002778, 3392.2197894484407, 3504.807235602015, 3576.6780989710533, 3598.820058997092, 3604.6034936157002, 1025.3079171559168, 1087.0705546757567, 1120.6077872744474, 1126.9436528173558, 1145.0496088246734, 803.3171803966582, 823.1069289820492, 826.2439867521271, 827.664795757707, 830.0, 4983.227599722049, 5016.1723315653235, 5106.412762532282, 5157.587393008625, 5258.7370631468275, 804.5574933786511, 815.4872711120786, 827.995860020708, 862.2799962031773, 905.9852964679601, 3332.500124981272, 3332.7667063305335, 3397.473391624302, 3420.7605467617027, 3500.1599616091953, 9438.95280523593, 9642.566084526214, 9669.419834809934, 9736.659216927515, 9804.65683701067, 8386.371022173362, 8891.866622000674, 9698.224142068617, 9713.660021899199, 9716.125548700651, 7026.683799229047, 7303.050603421521, 7306.59813710251, 7307.817304567428, 7316.926830731837, 5170.302009228856, 5173.948260517347, 5192.792288308426, 5236.711980841091, 5455.454454554671, 8436.493810371398, 8485.575721214038, 8591.140885911358, 8622.439541429787, 8638.17937295956, 8636.265917397091, 8755.69355072595, 8798.0, 8901.154390332907, 8901.287896968097, 5939.46544810969, 6109.816705498843, 6187.84530386744, 6264.812055638338, 6316.14732011191, 7179.784606461814, 7243.058402407653, 7249.0, 7250.347468727839, 7253.455990800606, 6464.450521705708, 6555.934440655723, 6594.538382313192, 6600.207975042834, 6691.698873550605, 6165.321814600301, 6182.28903676083, 6203.565750397429, 6261.467775239155, 6346.397092276226, 6050.334463209131, 6170.938290617037, 6189.288231853395, 6194.442500175006, 6196.907046394217, 4289.485261768607, 4357.71674841147, 4384.430024096847, 4444.466664000341, 4465.124647647931, 4245.150969805989, 4350.52144264137, 4494.0, 4507.4365704286965, 4508.301213311811], "value": 4013.2790990335343, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.1299961117812, 288.3210040354964, 291.32994113538854, 300.3302635123674, 301.19430523350036, 4826.372571565696, 4835.2505361669, 4860.513948605138, 4865.318855360252, 4893.951060489394, 4795.712257264567, 4803.783829727662, 4803.807847686088, 4816.879578010551, 4817.108834865552, 3804.847806087767, 3808.371618682928, 3808.7905165215902, 3809.5047643806265, 3818.4081467372603, 3647.270545890819, 3817.656410923016, 3820.7134464915102, 3822.9426558601645, 3827.5789663137034, 3695.7043436525014, 3721.641600815696, 3758.229562939591, 3761.9435708464393, 3763.266163098197, 3753.3244016077097, 3759.0, 3760.360738674432, 3765.3975363941913, 3779.79211143387, 3120.641126270485, 3250.983745081283, 3272.6236482804543, 3300.1584595928125, 3310.7682462227654, 4472.351509031205, 4664.836730714443, 4676.649251306131, 4713.764311784432, 4732.881677958044, 4304.78476076195, 4305.763183024932, 4312.654987600984, 4314.309710446313, 4320.783960801948, 4749.145153872301, 5058.558310881418, 5069.898602027975, 5071.793769710188, 5074.67014644047, 3483.9548135559485, 3491.598466176397, 3501.7898926064518, 3502.3713973002677, 3516.6307537708426, 5206.297149884755, 5245.872137490496, 5251.372074656869, 5263.894722105537, 5265.605079619044, 3616.5660120785674, 3621.8732344367822, 3621.9818900905852, 3627.510286111394, 3628.385368510987, 3411.8976430707116, 3581.6955558777277, 3606.585242697071, 3678.1057755256065, 3685.1708365618056, 4143.254214241405, 4143.440635514227, 4156.8129434175535, 4156.896077598024, 4156.916861662749, 4981.854173540106, 4989.600831933437, 4997.825076122318, 5002.849914502498, 5026.296318515338, 1216.6069850021674, 1245.4768997021272, 1260.6785269756153, 1264.7091169031175, 1265.2471779291307, 802.4102284820652, 802.4182467710863, 813.3777660090036, 814.3810703865105, 816.2368185746346, 3892.279928213233, 3923.8234279457492, 3932.6853851691794, 3967.206558688274, 3971.4837071180564, 4510.594046535827, 4530.02604440047, 4533.659975501851, 4534.410526631583, 4558.49856515783, 3946.0, 3947.230290093404, 3966.591859889755, 3968.2857085724845, 4116.403121547419, 2682.450097729961, 2747.766439852595, 2753.490604238222, 2757.5036493431376, 2758.3517873299757, 4630.4443466784205, 4757.381540399726, 4856.757162141949, 4863.586595139382, 4875.195592727231, 5283.471652834763, 5293.258943747878, 5312.920306195333, 5326.973365133227, 5344.4922732340365, 4849.878753031202, 4862.149123903374, 4862.41651001882, 4894.433781189985, 4895.922896962663, 4974.477679843564, 5083.72039537829, 5112.105381558138, 5132.7433628317685, 5146.816232266525, 5062.468440813809, 5074.340335756476, 5075.822346217865, 5102.948970510248, 5108.591312694901, 4759.690620109682, 4871.171900776805, 4891.682040667345, 4919.852404427873, 4922.876928076684, 3652.2330310635066, 3670.7614005089586, 3686.834092465792, 3689.4281386385155, 3694.4273637586216, 5146.948530514647, 5176.844694659167, 5180.704823794052, 5190.97404512975, 5199.740012999259, 5004.099262132851, 5025.874353141201, 5038.269450929522, 5056.974715126548, 5067.0879241735365, 4806.591439727662, 4998.525140111684, 4999.325091112799, 5008.724520151427, 5026.773795179299, 4941.876453088702, 4949.257611358325, 4967.317648469931, 4971.154903666457, 4989.875253118701, 5057.620678449058, 5070.721110338966, 5082.593392528663, 5093.719845408538, 5107.395228433451, 4726.26742854858, 4971.0, 5009.348784657971, 5009.448960614257, 5012.072766538202], "value": 3739.088199583174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7721334252957, 579.3916387792816, 590.0672020980168, 618.5979113576175, 687.88649872771, 11720.355380454072, 12360.876391236096, 13110.147840390367, 13529.12060716054, 13533.255670938106, 12497.43761530731, 13163.0, 13534.526291579798, 13552.39014244359, 13573.321333933289, 617.1206031405229, 735.746167572188, 762.4281788658507, 769.522895804602, 769.6267310354474, 747.1295940229626, 768.108993567459, 768.4313607930119, 778.1246098139593, 778.7469072551444, 812.1999830167281, 818.7543736878943, 819.0499021135485, 819.1439945257191, 819.4468733604823, 635.240887139868, 807.8868958345836, 809.8785182222714, 810.7040930060544, 811.6550466051934, 575.1143239411301, 590.2150140313415, 590.822753174046, 595.8272101090722, 596.2010905386802, 12772.61682149537, 12796.680082997906, 12804.61586152417, 12810.743785124245, 12822.0, 11794.646160615195, 11821.586244481488, 12277.815832762515, 12373.752524949541, 13439.731205375936, 9861.852072218922, 9999.0, 11691.356975366352, 11747.47136378865, 11853.170278080537, 3089.7837151399413, 3118.2549708067595, 3174.873005079794, 3210.085125739153, 3280.1471617379416, 68199.3180068198, 68617.65691171562, 69242.30757692459, 69452.6527367365, 70002.2999770006, 10288.948555257175, 10388.48057597117, 10512.540022677485, 10801.351918884735, 10804.1896857736, 18917.14872830726, 18918.3378581749, 19019.714704279446, 19030.809691902905, 19278.32525861588, 6775.254721980578, 6831.487638427137, 6849.657517124124, 6967.825804354931, 7088.184858741311, 3464.8094354810223, 3504.369213541587, 3534.5581802274714, 3542.362374772514, 3602.945955810665, 2828.208101731477, 2897.6590487342824, 2940.1767505098605, 2943.7644988401303, 2949.483840327934, 469.28199854223095, 475.60999980016055, 480.06147980697654, 481.75912043978013, 487.29829046174103, 439.33660173138793, 441.4966937691035, 552.4972275229521, 594.3343455330058, 594.5332913662754, 7175.282471752783, 7493.288137626917, 7825.604803460788, 8200.917990820135, 8381.235860222772, 511.4501910446285, 512.2546694559408, 564.6442741073098, 565.4402141879509, 578.9937865296766, 3672.8714494992546, 3769.679577235911, 3771.6228377162615, 3817.9427308590393, 3856.2094770571966, 53543.73228133834, 84207.5789621048, 84278.57860710657, 86216.56891715502, 87796.56101719578, 72685.2731472689, 79723.0, 80270.5986470064, 90722.0, 90866.0, 45675.915141016594, 46244.537554624694, 50348.49651503511, 84381.57809211037, 85231.14768852232, 8101.149379315087, 8496.787580310542, 8537.18896704812, 8548.230659240699, 8786.384953053224, 44766.55233447754, 46871.76564117157, 47213.29180062233, 47298.05403891972, 47702.284465733734, 53455.73272133614, 58672.0, 61631.38368616257, 68715.65642171758, 70159.29840701527, 11064.723381915517, 11170.441477926233, 11394.316341019565, 11414.543418263176, 11700.824487632523, 11871.525138994344, 11930.22453540517, 11972.102092342935, 12756.553520626734, 12779.23324600527, 10876.12990960737, 11034.393108378796, 11077.446127693744, 11601.825972610586, 11639.41802909868, 10914.290571112851, 11017.0, 11208.159388046091, 11703.531858725555, 11720.472578733807, 10467.476626168813, 10662.46687665598, 10805.135589152691, 11352.94323528377, 12133.635990920286, 9119.404104281857, 9712.5143742814, 10185.592576296865, 10257.640982565574, 10308.948455257676, 9369.437833729999, 9533.23734101284, 9548.331616787036, 9552.42685438876, 9845.212383009486], "value": 6375.529248871026, "unit": "score"}], "name": "dromaeo_css", "value": 6337.661729244627, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 110.0, 116.0, 116.0, 117.0, 122.0, 113.0, 116.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 151.0, 190.0, 123.0, 151.0, 154.0, 133.0, 192.0, 137.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 179.0, 79.0, 77.0, 77.0, 109.0, 109.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 151.0, 87.0, 86.0, 88.0, 141.0, 86.0, 85.0, 133.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 83.0, 83.0, 87.0, 82.0, 81.0, 83.0, 83.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 144.0, 139.0, 132.0, 132.0, 136.0, 140.0, 164.0, 146.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 174.0, 171.0, 175.0, 173.0, 174.0, 176.0, 171.0, 168.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 69.0, 67.0, 70.0, 69.0, 69.0, 67.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1580.3000000000002, "alertThreshold": 2.0}]} 11:57:38 INFO - Return code: 0 11:57:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:57:38 INFO - # TBPL SUCCESS # 11:57:38 INFO - Running post-action listener: _resource_record_post_action 11:57:38 INFO - [mozharness: 2016-08-23 18:57:38.305387Z] Finished run-tests step (success) 11:57:38 INFO - Running post-run listener: _resource_record_post_run 11:57:38 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 406220800; Read time: 0; Write time: 275580 11:57:38 INFO - TinderboxPrint: CPU usage
13.3% 11:57:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:57:38 INFO - TinderboxPrint: I/O write bytes / time
406,220,800 / 275,580 11:57:38 INFO - TinderboxPrint: CPU idle
8,331.0 (86.7%) 11:57:38 INFO - TinderboxPrint: CPU user
1,207.7 (12.6%) 11:57:38 INFO - TinderboxPrint: Swap in / out
0 / 0 11:57:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114192384; Read time: 0; Write time: 118520 11:57:38 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292028416; Read time: 0; Write time: 157060 11:57:38 INFO - Running post-run listener: _upload_blobber_files 11:57:38 INFO - Blob upload gear active. 11:57:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:57:38 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:57:38 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:57:38 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:57:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:40 INFO - (blobuploader) - INFO - Done attempting. 11:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:40 INFO - (blobuploader) - INFO - Done attempting. 11:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:46 INFO - (blobuploader) - INFO - Done attempting. 11:57:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:57:46 INFO - Return code: 0 11:57:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:57:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:57:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/730343a8bde8dfded6cd607706e9caa27f512749736c02ad084c3e86f6cc84c083ee31ff393a5db5d8052b1afe883ed0b409ac8cd44f8920d0fd6a0beb46f1bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/091de6891045cab66344d5d2a9000e68517c67d59abef5ed862dbaeba73a522f784ff4f9b09504de64528f50ddf839d77d8eb163fb2a4125cf491cfb747c8b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c73215657b883e3b8b07c36130ddc9a3f28940e10b277f0c3e380d826c9b999c43ead090fa67db4cd443e8ad369d9885364982cc08a51ac29f1656806bab671"} 11:57:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:57:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:57:46 INFO - Contents: 11:57:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/730343a8bde8dfded6cd607706e9caa27f512749736c02ad084c3e86f6cc84c083ee31ff393a5db5d8052b1afe883ed0b409ac8cd44f8920d0fd6a0beb46f1bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/091de6891045cab66344d5d2a9000e68517c67d59abef5ed862dbaeba73a522f784ff4f9b09504de64528f50ddf839d77d8eb163fb2a4125cf491cfb747c8b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c73215657b883e3b8b07c36130ddc9a3f28940e10b277f0c3e380d826c9b999c43ead090fa67db4cd443e8ad369d9885364982cc08a51ac29f1656806bab671"} 11:57:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:57:46 INFO - Copying logs to upload dir... 11:57:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:57:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.908508 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-23 11:57:45.372348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:45.375548) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/730343a8bde8dfded6cd607706e9caa27f512749736c02ad084c3e86f6cc84c083ee31ff393a5db5d8052b1afe883ed0b409ac8cd44f8920d0fd6a0beb46f1bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/091de6891045cab66344d5d2a9000e68517c67d59abef5ed862dbaeba73a522f784ff4f9b09504de64528f50ddf839d77d8eb163fb2a4125cf491cfb747c8b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c73215657b883e3b8b07c36130ddc9a3f28940e10b277f0c3e380d826c9b999c43ead090fa67db4cd443e8ad369d9885364982cc08a51ac29f1656806bab671"} build_url:https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/HoXDU_fsSmm_bjaTWy0Rjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/730343a8bde8dfded6cd607706e9caa27f512749736c02ad084c3e86f6cc84c083ee31ff393a5db5d8052b1afe883ed0b409ac8cd44f8920d0fd6a0beb46f1bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/091de6891045cab66344d5d2a9000e68517c67d59abef5ed862dbaeba73a522f784ff4f9b09504de64528f50ddf839d77d8eb163fb2a4125cf491cfb747c8b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c73215657b883e3b8b07c36130ddc9a3f28940e10b277f0c3e380d826c9b999c43ead090fa67db4cd443e8ad369d9885364982cc08a51ac29f1656806bab671"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:45.401396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:45.401824) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471977413.308797-1217260431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:45.484596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:57:45.485027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:57:45.485366) ========= ========= Total master_lag: 0.17 =========