【89】archivematica1.13.0へのアップデート：from 1.12.0 upgrade to 1.13.0

人が少ないながら今日もスタート。
前回出てないので「なんとも・・・」のなかなので、不適格なことがあったらすみません。

結論からいうと、最期の＜正解＞から見ていただければアップグレードはうまくいきます。

Ver. 1.12.0から最新Ver. 1.13.0へアップグレードです。
同じような問題を抱えている方がいたらしく、それに対するコメントにしたがって進めます。

ちなみに、参考にしたのは
https://groups.google.com/g/archivematica/c/QcRQobqdnU4?pli=1
https://docs.djangoproject.com/en/1.11/ref/django-admin/#showmigrations

です。

1.13のドキュメンテーション：Upgradeの手順を確認していきます。
https://www.archivematica.org/en/docs/archivematica-1.13/admin-manual/installation-setup/upgrading/upgrading/#upgrade

ここでは＜2．Update packages sources＞のコマンドに
"sudo -sh" を冒頭に入れます。すなわち、

 'echo "deb [arch=amd64] http://packages.archivematica.org/1.13.x/ubuntu bionic main" >> /etc/apt/sources.list'
sudo sh -c 'echo "deb [arch=amd64] http://packages.archivematica.org/1.13.x/ubuntu-externals bionic main" >> /etc/apt/sources.list'

としました。
結果は…

見事にエラーです。前回の復習的作業でした。

こっからです。
エラーの詳細を確認します。

sudo journalctl -u archivematica-mcp-server -xe

大量なエラーログの結果、

django.db.utils.OperationalError: (1054, "Unknown colum 'Transfers.status' in 'where clause'")

を確認しました。

ここから、mysqlでDBを確認。

sudo mysql -u root -p

Pass:

>mysql> show databases;

DB"MCP”をセレクトします。

mysql> use MCP;
ここで、次のTransfersを選択。

mysql> select * from Transfers;

と、カラだとのこと。が、並行に作業していたW氏のPCでは、

と、artefactuals社の返答の通りの表示に。ですので、ここからはW氏のPCに替えます。

次に、

https://www.archivematica.org/en/docs/archivematica-1.13/admin-manual/installation-setup/upgrading/upgrading/#upgrade-centos

のうち、"4"のコマンドを実行します。

実行すると、質問者と同じエラー表示が出ます。
ImportError: bad magic number in 'components.administration.management': b'\x03\xf3\r\n

そこで、指示通りに"*.pyc"ファイルをすべて削除するコマンドを実行します。

sudo find . -name "*.pyc" -exec rm -f {} \;

結果は。。。うまくいかず。。。これでうまくいったって言ってたじゃ無いOlixxx!!

ここで、mysqlにログイン

mysql> use MCP;

mysql> select * from django_migrations;

から、"81"が入ってないとならないので確認しましたが、ありません。。。

そこで、またまた質問に戻ります。再度、

sudo find . -name "*.pyc" -exec rm -f {} \;

から、”4”のコマンドを再実行します。

すると、いっぱい"OK"の文字が！！←W氏のオペレートは早すぎてキャプチャーできず。

ここで、再起動。

結果は。。。。うまくつながりました！！！！

＜正解＞

振り返りますと、

"Upgrad on Ubuntu packages"の手順"4"と"5"の間に下記のコマンドを実行します。

まず、Dashboardにcdします。

cd /usr/share /archivematica/dashboard/

次に、

sudo find . -name "*.pyc" -exec rm -f {} \;

を実行。

をし、ストレージサービス等のRestartをするとうまくいくということになります。

めでたしめでたし！！

【88】archivematica1.13.0へのアップデート

本日は参加者も少なく短時間で終わりました。お盆ですしね。その分、内容も短いです。

前回、1.12から1.13にアップデートしたところ、ダッシュボードの右上に、"Error trying to connect to MCP server. Trying again..."と表示されてしまいました。

どのようなエラーが起こっているかを確認します（日付は別の日となっていますが、道場当日に起こっていたものと同じです）。

ダッシュボードのエラー。

$ sudo journalctl -u archivematica-dashboard

 7月 02 19:47:52 matica-vm systemd[1]: Started Archivematica Dashboard.

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28503] [INFO] Starting gunicorn 19.9.0

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28503] [INFO] Listening at: http://127.0.0.1:8002 (28503)

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28503] [INFO] Using worker: gevent

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28646] [INFO] Booting worker with pid: 28646

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28656] [INFO] Booting worker with pid: 28656

 7月 02 19:47:52 matica-vm gunicorn[28503]: [2021-07-02 19:47:52 +0000] [28697] [INFO] Booting worker with pid: 28697

 7月 02 19:47:53 matica-vm gunicorn[28503]: /usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/cryptography/__init__.py:39: CryptographyDepreca

 7月 02 19:47:53 matica-vm gunicorn[28503]:   CryptographyDeprecationWarning,

 7月 02 19:47:53 matica-vm gunicorn[28503]: /usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/cryptography/__init__.py:39: CryptographyDepreca

 7月 02 19:47:53 matica-vm gunicorn[28503]:   CryptographyDeprecationWarning,

 7月 02 19:47:53 matica-vm gunicorn[28503]: /usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/cryptography/__init__.py:39: CryptographyDepreca

 7月 02 19:47:53 matica-vm gunicorn[28503]:   CryptographyDeprecationWarning,

 7月 02 19:48:06 matica-vm gunicorn[28503]: [2021-07-02 10:48:06 +0000] [28646] [ERROR] Exception in worker process

 7月 02 19:48:06 matica-vm gunicorn[28503]: Traceback (most recent call last):

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/arbiter.py", line 583, in spawn

 7月 02 19:48:06 matica-vm gunicorn[28503]:     worker.init_process()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/workers/ggevent.py", line 203,

 7月 02 19:48:06 matica-vm gunicorn[28503]:     super(GeventWorker, self).init_process()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/workers/base.py", line 129, in

 7月 02 19:48:06 matica-vm gunicorn[28503]:     self.load_wsgi()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/workers/base.py", line 138, in

 7月 02 19:48:06 matica-vm gunicorn[28503]:     self.wsgi = self.app.wsgi()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/app/base.py", line 67, in wsgi

 7月 02 19:48:06 matica-vm gunicorn[28503]:     self.callable = self.load()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/app/wsgiapp.py", line 52, in lo

 7月 02 19:48:06 matica-vm gunicorn[28503]:     return self.load_wsgiapp()

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/app/wsgiapp.py", line 41, in lo

 7月 02 19:48:06 matica-vm gunicorn[28503]:     return util.import_app(self.app_uri)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/util.py", line 350, in import_a

 7月 02 19:48:06 matica-vm gunicorn[28503]:     __import__(module)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gevent/builtins.py", line 96, in __impor

 7月 02 19:48:06 matica-vm gunicorn[28503]:     result = _import(*args, **kwargs)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/dashboard/wsgi.py", line 15, in <module>

 7月 02 19:48:06 matica-vm gunicorn[28503]:     elasticSearchFunctions.setup_reading_from_conf(settings)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/lib/archivematica/archivematicaCommon/elasticSearchFunctions.py", line 148, in setup_reading_from_conf

 7月 02 19:48:06 matica-vm gunicorn[28503]:     settings.SEARCH_ENABLED,

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/lib/archivematica/archivematicaCommon/elasticSearchFunctions.py", line 137, in setup

 7月 02 19:48:06 matica-vm gunicorn[28503]:     create_indexes_if_needed(_es_client, indexes)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/lib/archivematica/archivematicaCommon/elasticSearchFunctions.py", line 214, in create_indexes_if_needed

 7月 02 19:48:06 matica-vm gunicorn[28503]:     if client.indices.exists(index=",".join(indexes)):

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/elasticsearch/client/utils.py", line 84,

 7月 02 19:48:06 matica-vm gunicorn[28503]:     return func(*args, params=params, **kwargs)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/elasticsearch/client/indices.py", line 2

 7月 02 19:48:06 matica-vm gunicorn[28503]:     return self.transport.perform_request("HEAD", _make_path(index), params=params)

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/elasticsearch/transport.py", line 358, i

 7月 02 19:48:06 matica-vm gunicorn[28503]:     timeout=timeout,

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/elasticsearch/connection/http_urllib3.py

 7月 02 19:48:06 matica-vm gunicorn[28503]:     raise ConnectionError("N/A", str(e), e)

 7月 02 19:48:06 matica-vm gunicorn[28503]: ConnectionError: ConnectionError(<urllib3.connection.HTTPConnection object at 0x7f586f44cbd0>: Failed to establish a new connection: [Errno 111

 7月 02 19:48:06 matica-vm gunicorn[28503]: [2021-07-02 10:48:06 +0000] [28646] [INFO] Worker exiting (pid: 28646)

 7月 02 19:48:06 matica-vm gunicorn[28503]: [2021-07-02 10:48:06 +0000] [28697] [ERROR] Exception in worker process

 7月 02 19:48:06 matica-vm gunicorn[28503]: Traceback (most recent call last):

 7月 02 19:48:06 matica-vm gunicorn[28503]:   File "/usr/share/archivematica/virtualenvs/archivematica-dashboard/local/lib/python2.7/site-packages/gunicorn/arbiter.py", line 583, in spawn

 7月 02 19:48:06 matica-vm gunicorn[28503]:     worker.init_process()

次に、MCP Serverのエラー。

$ sudo journalctl -u archivematica-mcp-server

-- Logs begin at Fri 2021-07-02 17:33:32 JST, end at Fri 2021-08-13 22:21:03 JST. --

 7月 02 19:44:47 matica-vm systemd[1]: Started Archivematica MCP Server Service.

 7月 02 19:44:47 matica-vm python[24961]: Traceback (most recent call last):

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/lib/archivematica/MCPServer/archivematicaMCP.py", line 2, in <module>

 7月 02 19:44:47 matica-vm python[24961]:     from server.mcp import main

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/lib/archivematica/MCPServer/server/mcp.py", line 36, in <module>

 7月 02 19:44:47 matica-vm python[24961]:     django.setup()

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/share/archivematica/virtualenvs/archivematica-mcp-server/local/lib/python2.7/site-packages/django

 7月 02 19:44:47 matica-vm python[24961]:     apps.populate(settings.INSTALLED_APPS)

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/share/archivematica/virtualenvs/archivematica-mcp-server/local/lib/python2.7/site-packages/django

 7月 02 19:44:47 matica-vm python[24961]:     app_config = AppConfig.create(entry)

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/share/archivematica/virtualenvs/archivematica-mcp-server/local/lib/python2.7/site-packages/django

 7月 02 19:44:47 matica-vm python[24961]:     module = import_module(entry)

 7月 02 19:44:47 matica-vm python[24961]:   File "/usr/lib/python2.7/importlib/__init__.py", line 37, in import_module

 7月 02 19:44:47 matica-vm python[24961]:     __import__(name)

 7月 02 19:44:47 matica-vm python[24961]: ImportError: No module named main

 7月 02 19:44:47 matica-vm systemd[1]: archivematica-mcp-server.service: Main process exited, code=exited, status=1/FAILURE

 7月 02 19:44:47 matica-vm systemd[1]: archivematica-mcp-server.service: Failed with result 'exit-code'.

 7月 02 20:00:34 matica-vm systemd[1]: Started Archivematica MCP Server Service.

 7月 02 20:00:35 matica-vm python[6838]: /usr/share/archivematica/virtualenvs/archivematica-mcp-server/local/lib/python2.7/site-packages/cryptography/__

 7月 02 20:00:35 matica-vm python[6838]:   CryptographyDeprecationWarning,

 7月 02 21:39:34 matica-vm systemd[1]: Stopping Archivematica MCP Server Service...

 7月 02 21:39:35 matica-vm systemd[1]: Stopped Archivematica MCP Server Service.

Nginxのログ（/var/log/nginx/error.log）やダッシュボードのログ（/var/log/archivematica/dashboard/dashboard.debug.log）を確認しましたが、よくわからず。再度、同じアップグレードの処理を繰り返しましたが、効果なし。それで解散となりました。

次回の予定

8/20（金）です。

＜後日＞

次の日、個人的にもう一度確認してみました。上記のエラーが、/usr/share/archivematica/virtualenvs/archivematica-mcp-server/local/lib/python2.7/site-packagesに関係しているので、調べたところ、/usr/share/archivematica/virtualenvs/archivematica-mcp-server/local以下がごっそりありませんでした。

そこで、https://github.com/archivematica/Issues/issues/903を参照し、次のコマンドを遂行。

$ sudo apt install virtualenv

すると、archivematica-mcp-server/local以下が入りました。

ところが、またも"Error trying to connect to MCP server. Trying again..."です。一応、エラーを確認します。

Mcp Server

$ sudo journalctl -u archivematica-mcp-server

8月 14 17:57:32 matica-vm systemd[1]: Started Archivematica MCPServer.

 8月 14 17:57:32 matica-vm python[28671]: Traceback (most recent call last):

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/back

 8月 14 17:57:32 matica-vm python[28671]:     return self.cursor.execute(sql, params)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/back

 8月 14 17:57:32 matica-vm python[28671]:     return self.cursor.execute(query, args)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/cursor

 8月 14 17:57:32 matica-vm python[28671]:     res = self._query(query)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/cursor

 8月 14 17:57:32 matica-vm python[28671]:     db.query(q)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/connec

 8月 14 17:57:32 matica-vm python[28671]:     _mysql.connection.query(self, query)

 8月 14 17:57:32 matica-vm python[28671]: MySQLdb._exceptions.OperationalError: (1054, "Unknown column 'Transfers.status' in 'where clause'")

 8月 14 17:57:32 matica-vm python[28671]: The above exception was the direct cause of the following exception:

 8月 14 17:57:32 matica-vm python[28671]: Traceback (most recent call last):

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/lib/archivematica/MCPServer/archivematicaMCP.py", line 5, in <module>

 8月 14 17:57:32 matica-vm python[28671]:     main()

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/lib/archivematica/MCPServer/server/mcp.py", line 106, in main

 8月 14 17:57:32 matica-vm python[28671]:     Package.cleanup_old_db_entries()

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/lib/python3.6/contextlib.py", line 52, in inner

 8月 14 17:57:32 matica-vm python[28671]:     return func(*args, **kwds)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/lib/archivematica/MCPServer/server/packages.py", line 574, in cleanup_old_db_entries

 8月 14 17:57:32 matica-vm python[28671]:     completed_at=completed_at,

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/mode

 8月 14 17:57:32 matica-vm python[28671]:     rows = query.get_compiler(self.db).execute_sql(CURSOR)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/mode

 8月 14 17:57:32 matica-vm python[28671]:     cursor = super(SQLUpdateCompiler, self).execute_sql(result_type)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/mode

 8月 14 17:57:32 matica-vm python[28671]:     raise original_exception

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/mode

 8月 14 17:57:32 matica-vm python[28671]:     cursor.execute(sql, params)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/back

 8月 14 17:57:32 matica-vm python[28671]:     return self.cursor.execute(sql, params)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/util

 8月 14 17:57:32 matica-vm python[28671]:     six.reraise(dj_exc_type, dj_exc_value, traceback)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/utils/s

 8月 14 17:57:32 matica-vm python[28671]:     raise value.with_traceback(tb)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/back

 8月 14 17:57:32 matica-vm python[28671]:     return self.cursor.execute(sql, params)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/db/back

 8月 14 17:57:32 matica-vm python[28671]:     return self.cursor.execute(query, args)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/cursor

 8月 14 17:57:32 matica-vm python[28671]:     res = self._query(query)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/cursor

 8月 14 17:57:32 matica-vm python[28671]:     db.query(q)

 8月 14 17:57:32 matica-vm python[28671]:   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/MySQLdb/connec

 8月 14 17:57:32 matica-vm python[28671]:     _mysql.connection.query(self, query)

 8月 14 17:57:32 matica-vm python[28671]: django.db.utils.OperationalError: (1054, "Unknown column 'Transfers.status' in 'where clause'")

 8月 14 17:57:33 matica-vm systemd[1]: archivematica-mcp-server.service: Main process exited, code=exited, status=1/FAILURE

 8月 14 17:57:33 matica-vm systemd[1]: archivematica-mcp-server.service: Failed with result 'exit-code'.

ダッシュボード

$ sudo journalctl -u archivematica-dashboard

8月 14 17:42:04 matica-vm systemd[1]: Stopping Archivematica Dashboard...

 8月 14 17:42:04 matica-vm gunicorn[17544]: [2021-08-14 17:42:04 +0900] [17544] [INFO] Handling signal: term

 8月 14 17:42:34 matica-vm gunicorn[17544]: [2021-08-14 17:42:34 +0900] [17544] [INFO] Shutting down: Master

 8月 14 17:42:34 matica-vm systemd[1]: Stopped Archivematica Dashboard.

 8月 14 17:42:34 matica-vm systemd[1]: Started Archivematica Dashboard.

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28072] [INFO] Starting gunicorn 19.9.0

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28072] [INFO] Listening at: http://127.0.0.1:8002 (28072)

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28072] [INFO] Using worker: gevent

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28076] [INFO] Booting worker with pid: 28076

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28077] [INFO] Booting worker with pid: 28077

 8月 14 17:42:34 matica-vm gunicorn[28072]: [2021-08-14 17:42:34 +0900] [28078] [INFO] Booting worker with pid: 28078

 8月 14 17:57:46 matica-vm systemd[1]: Stopping Archivematica Dashboard...

 8月 14 17:57:46 matica-vm gunicorn[28072]: [2021-08-14 17:57:46 +0900] [28072] [INFO] Handling signal: term

 8月 14 17:57:47 matica-vm gunicorn[28072]: [2021-08-14 08:57:47 +0000] [28078] [INFO] Worker exiting (pid: 28078)

 8月 14 17:58:06 matica-vm gunicorn[28072]: [2021-08-14 08:58:06 +0000] [28077] [INFO] Worker exiting (pid: 28077)

 8月 14 17:58:16 matica-vm gunicorn[28072]: [2021-08-14 17:58:16 +0900] [28072] [INFO] Shutting down: Master

 8月 14 17:58:16 matica-vm systemd[1]: Stopped Archivematica Dashboard.

 8月 14 17:58:16 matica-vm systemd[1]: Started Archivematica Dashboard.

 8月 14 17:58:16 matica-vm gunicorn[28698]: [2021-08-14 17:58:16 +0900] [28698] [INFO] Starting gunicorn 19.9.0

 8月 14 17:58:16 matica-vm gunicorn[28698]: [2021-08-14 17:58:16 +0900] [28698] [INFO] Listening at: http://127.0.0.1:8002 (28698)

 8月 14 17:58:16 matica-vm gunicorn[28698]: [2021-08-14 17:58:16 +0900] [28698] [INFO] Using worker: gevent

 8月 14 17:58:16 matica-vm gunicorn[28698]: [2021-08-14 17:58:16 +0900] [28701] [INFO] Booting worker with pid: 28701

 8月 14 17:58:17 matica-vm gunicorn[28698]: [2021-08-14 17:58:17 +0900] [28703] [INFO] Booting worker with pid: 28703

 8月 14 17:58:17 matica-vm gunicorn[28698]: [2021-08-14 17:58:17 +0900] [28705] [INFO] Booting worker with pid: 28705

続いて、ダッシュボードのログ（/var/log/archivematica/dashboard/dashboard.debug.log）を確認。

4873 ERROR     2021-08-13 10:45:56  django.request:exception:handle_uncaught_exception:135:  Internal Server Error: /status/

4874 Traceback (most recent call last):

4875   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/core/handlers/exception.py", line 41, in inner

4876     response = get_response(request)

4877   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/core/handlers/base.py", line 187, in _get_response

4878     response = self.process_exception_by_middleware(e, request)

4879   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/django/core/handlers/base.py", line 185, in _get_response

4880     response = wrapped_callback(request, *callback_args, **callback_kwargs)

4881   File "/usr/share/archivematica/dashboard/main/views.py", line 80, in status

4882     xml = etree.XML(client.list())

4883   File "/usr/share/archivematica/dashboard/contrib/mcp/client.py", line 162, in list

4884     b"getJobsAwaitingApproval", six.moves.cPickle.dumps({}, protocol=0)

4885   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/gearman/client.py", line 49, in submit_job

4886     jobs_to_submit=[job_info], **kwargs

4887   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/gearman/client.py", line 70, in submit_multiple_jobs

4888     return self.submit_multiple_requests(requests_to_submit, **kwargs)

4889   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/gearman/client.py", line 90, in submit_multiple_requests

4890     processed_requests = self.wait_until_jobs_completed(processed_requests, poll_timeout=time_remaining)

4891   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/gearman/client.py", line 134, in wait_until_jobs_completed

4892     self.poll_connections_until_stopped(self.connection_list, continue_while_jobs_incomplete, timeout=poll_timeout)

4893   File "/usr/share/archivematica/virtualenvs/archivematica/lib/python3.6/site-packages/gearman/connection_manager.py", line 248, in poll_connections_until_stopped

4894     raise ServerUnavailable('Found no valid connections in list: %r' % self.connection_list)

4895 gearman.errors.ServerUnavailable: Found no valid connections in list: [GearmanConnection(host='127.0.0.1', port=4730, keyfile=None, certfile=None, ca_certs=None)]

続いて、Nginxのログ（/var/log/nginx/error.log）

1  2021/08/13 16:23:17 [error] 933#933: *474 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.56.1, server: _, request: "GET /transfer/status/?1628839396328 HTTP/1.1", upstream: "http://127.0.0.1:8002/transfer/status/?1628839396328", host: "192.168.56.3", referrer: "http://192.168.56.3/transfer/"

2 2021/08/13 16:23:28 [error] 933#933: *474 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.56.1, server: _, request: "GET /transfer/status/?1628839406336 HTTP/1.1", upstream: "http://127.0.0.1:8002/transfer/status/?1628839406336", host: "192.168.56.3", referrer: "http://192.168.56.3/transfer/"

3 2021/08/13 16:23:35 [error] 933#933: *463 upstream prematurely closed connection while reading response header from upstream, client: 192.168.56.1, server: _, request: "GET /status/?1628839311270 HTTP/1.1", upstream: "http://127.0.0.1:8002/status/?1628839311270", host: "192.168.56.3", referrer: "http://192.168.56.3/transfer/"

4 2021/08/13 19:46:46 [error] 933#933: *877 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.56.1, server: _, request: "GET /transfer/status/?1628851605901 HTTP/1.1", upstream: "http://127.0.0.1:8002/transfer/status/?1628851605901", host: "192.168.56.3", referrer: "http://192.168.56.3/transfer/"

5 2021/08/13 19:46:53 [error] 933#933: *811 upstream prematurely closed connection while reading response header from upstream, client: 192.168.56.1, server: _, request: "GET /status/?1628851560793 HTTP/1.1", upstream: "http://127.0.0.1:8002/status/?1628851560793", host: "192.168.56.3", referrer: "http://192.168.56.3/transfer/"

ここで、よくわからなくなったので諦めました。Archivematicaの掲示板にError connecting to MCP serverがあがっています。

https://groups.google.com/g/archivematica/c/zDC2yh-pJ_E

ところが、エラーの種類が異なるようですので、どうしていいかわかりません。