Open OlegYankovic opened 2 years ago
I looked at all logs and I didn't found any errors. I mean look at this: It looks like MXNet starts initializing and this is it - no more logs from compreface-core. Instead, after one minute later, nginx just stops your request by timeout. I think MXNet just hangs during initialization. And this is a place where it connects to your GPU. Can't say what is the problem. I only can suggest to wait longer (like 10 minutes) and look at logs again. Probably there will be more logs from compreface-core with errors. I mean nginx decided not to wait anymore and return error, but it doesn't mean that MXNet stopped initialization process.
I increase nginx timout in compreface-ui to 1000 seconds. After 5 minutes after request was send another timeout error occure from compreface-api. And after waiting about 15 minutes more there was errors from compreface-core. If your next advice will be to increase timeout in compreface-api, please, give instructions how to do it. Also, don't know if it matter, but this GPU is “Lite Hash Rate”, so it harder to use it for mining of cryptocurrency. Don't know can it be the reason or not. docker_logs.txt
Seems like I'm having same issue with the OP, except I'm using the RTX 3050.
I did some digging and found that Deepstack also had some problem with RTX 3xxx series but there is workaround to fix it.
Maybe some apply to Compreface?
https://forum.deepstack.cc/t/deepstack-windows-version-beta-update/619/36
So I did some more digging and I think I figured out why MXNet is stuck at initializing as per @pospielov screenshot.
I checked the CUDA version in the docker container and it is CUDA-10, it appear that the RTX 3xxxx play with CUDA 11 and above.
So I tried installing CUDA 11 in the docker container and it no longer stuck at initializing! But there is some error that I couldn't figure out. Hoping that you guys could figure out the issue :)
@aididhaiqal Thanks for the information. After brief research I found this site: https://arnon.dk/category/gpus/ Looks like you are right, a new generation of Nvidia GPU requires at least CUDA 11.1. I asked our former contributor to check it as he also has rtx3060ti.
There are two problems with updating CUDA:
This is why I can't promise we fix it very soon, but I'll definitely put it a very high priority
Do let me know if there is anything I could help! I have 3050 ready and 3090 on the way
+1 i also got the problem with core being stuck on
spawned uWSGI master process (pid: 1)
spawned uWSGI worker 1 (pid: 53, cores: 1)
[18:03:01] src/nnvm/legacy_json_util.cc:209: Loading symbol saved by previous version v1.3.0. Attempting to upgrade...
[18:03:01] src/nnvm/legacy_json_util.cc:217: Symbol successfully upgraded!
[18:03:01] src/engine/engine.cc:55: MXNet start using engine: ThreadedEnginePerDevice
i just replaced my rtx2060 with a rtx3060 and this is the outcome.
Hi @pospielov, is there any timeline yet for a potential fix?
Unfortunately no, we don't have available ML contributors now
@pospielov I wonder is there anything I could assist or other people in the community could assist in getting it to work.
30xx GPUs not support CUDA 10, you have to modify gpu.Dockerfile with CUDA11
30xx GPUs not support CUDA 10, you have to modify gpu.Dockerfile with CUDA11
Do you have suggestion on how to do that? I tried to install Cuda-11 and Mxnet-cu112 via console but cuda installation keep failling
So I did try another method by looking into Nvidia docker image (https://hub.docker.com/layers/cuda/nvidia/cuda/11.2.2-cudnn8-runtime-ubuntu18.04/images/sha256-8a372c247cf10564947997c19679a862175d4ff1cecbb9283161e32d4f5223d6?context=explore)
Following the routine for Cuda 11.2 image, and installing Mxnet-Cu112 I was able to get Compreface to run on my RTX3050
@aididhaiqal nice!
Tested both on the ArcFace and MobileNet, both will run. However since this is my first time using Arcface, it seems to "stuck" on initial training on an image called Leona.jpg I think. @pospielov any idea?
apt-get update apt-get install -y cuda-cudart-11-2=11.2.152-1 cuda-compat-11-2 rm /usr/local/cuda ln -s cuda-11.2 /usr/local/cuda apt-get install -y cuda-libraries-11-2=11.2.2-1 libnpp-11-2=11.3.2.152-1 cuda-nvtx-11-2=11.2.152-1 libcusparse-11-2=11.4.1.1152-1 libcublas-11-2=11.4.1.1043-1 libnccl2=2.8.4-1+cuda11.2 apt-mark hold libcublas-11-2 libnccl2 apt-get install -y libcudnn8=8.1.1.33-1+cuda11.2 apt-mark hold libcudnn8 rm -rf /var/lib/apt/lists/* pip install mxnet-cu112
For those wondering what exact command did I run to get Compreface to run on RTX-3xxx, here you go. If there is invalid command, must be because some typo in version name so keep a lookout on that!
Tested both on the ArcFace and MobileNet, both will run. However since this is my first time using Arcface, it seems to "stuck" on initial training on an image called Leona.jpg I think. @pospielov any idea?
Could you describe a problem in detail?
Following the routine for Cuda 11.2 image, and installing Mxnet-Cu112 I was able to get Compreface to run on my RTX3050
Thanks, it will greatly speed up CompreFace fix
apt-get update apt-get install -y cuda-cudart-11-2=11.2.152-1 cuda-compat-11-2 rm /usr/local/cuda ln -s cuda-11.2 /usr/local/cuda apt-get install -y cuda-libraries-11-2=11.2.2-1 libnpp-11-2=11.3.2.152-1 cuda-nvtx-11-2=11.2.152-1 libcusparse-11-2=11.4.1.1152-1 libcublas-11-2=11.4.1.1043-1 libnccl2=2.8.4-1+cuda11.2 apt-mark hold libcublas-11-2 libnccl2 apt-get install -y libcudnn8=8.1.1.33-1+cuda11.2 apt-mark hold libcudnn8 rm -rf /var/lib/apt/lists/* pip install mxnet-cu112
For those wondering what exact command did I run to get Compreface to run on RTX-3xxx, here you go. If there is invalid command, must be because some typo in version name so keep a lookout on that!
In case anyone wondering, this workaround still working with 1.0.0 release
I made a first draft version of the image. Can anyone try to use this image to test if it works on 3xxx? pospielov/compreface-core:1.0.0-mobilenet-3xxx
I made a first draft version of the image. Can anyone try to use this image to test if it works on 3xxx? pospielov/compreface-core:1.0.0-mobilenet-3xxx
I tried with a GTX 1660. No go.
[uWSGI] getting INI configuration from uwsgi.ini
*** Starting uWSGI 2.0.19 (64bit) on [Thu May 26 06:54:16 2022] ***
compiled with version: 9.4.0 on 05 May 2022 14:03:34
os: Linux-5.17.9-1-default #1 SMP PREEMPT Wed May 18 10:03:12 UTC 2022 (eab1a2c)
nodename: e7809bffb815
machine: x86_64
clock source: unix
detected number of CPU cores: 32
current working directory: /app/ml
detected binary path: /usr/local/bin/uwsgi
!!! no internal routing support, rebuild with pcre support !!!
setgid() to 33
setuid() to 33
your memory page size is 4096 bytes
detected max file descriptor number: 1048576
lock engine: pthread robust mutexes
thunder lock: disabled (you can enable it with --thunder-lock)
uwsgi socket 0 bound to TCP address 0.0.0.0:3000 fd 3
Python version: 3.8.10 (default, Mar 15 2022, 12:22:08) [GCC 9.4.0]
Python main interpreter initialized at 0x563bc9d3fb10
python threads support enabled
your server socket listen backlog is limited to 100 connections
your mercy for graceful operations on workers is 60 seconds
mapped 145808 bytes (142 KB) for 1 cores
*** Operational MODE: single process ***
{"severity": "INFO", "message": "{'BUILD_VERSION': 'dev', 'CALCULATION_PLUGIN': 'insightface.Calculator@arcface_mobilefacenet', 'EXTRA_PLUGINS': ['insightface.Landmarks2d106Detector', 'insightface.GenderDetector', 'insightface.AgeDetector', 'insightface.facemask.MaskDetector'], 'FACE_DETECTION_PLUGIN': 'insightface.FaceDetector@retinaface_mnet025_v1', 'GPU_IDX': 0, 'IMG_LENGTH_LIMIT': 640, 'INTEL_OPTIMIZATION': False, 'IS_DEV_ENV': False, 'LOGGING_LEVEL_NAME': 'DEBUG', 'ML_PORT': 3000}", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Creating new app for WSGI", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
WSGI app 0 (mountpoint='') ready in 1 seconds on interpreter 0x563bc9d3fb10 pid: 1 (default app)
*** uWSGI is running in multiple interpreter mode ***
spawned uWSGI master process (pid: 1)
spawned uWSGI worker 1 (pid: 70, cores: 1)
[06:55:08] ../src/nnvm/legacy_json_util.cc:208: Loading symbol saved by previous version v1.2.0. Attempting to upgrade...
[06:55:08] ../src/nnvm/legacy_json_util.cc:216: Symbol successfully upgraded!
[06:55:08] ../src/engine/engine.cc:54: MXNet start using engine: ThreadedEnginePerDevice
[06:55:08] ../src/base.cc:48: GPU context requested, but no GPUs found.
{"severity": "CRITICAL", "message": "RuntimeError: simple_bind error. Arguments:\ndata: (1, 3, 480, 640)\nTraceback (most recent call last):\n File \"../src/storage/storage.cc\", line 97\nCUDA: Check failed: e == cudaSuccess || e == cudaErrorCudartUnloading: no CUDA-capable device is detected", "request": {"method": "POST", "path": "/find_faces", "filename": "20220423_182458.jpg", "api_key": "", "remote_addr": "172.26.64.26"}, "logger": "src.services.flask_.error_handling", "module": "error_handling", "traceback": "Traceback (most recent call last):\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/symbol/symbol.py\", line 1903, in simple_bind\n check_call(_LIB.MXExecutorSimpleBindEx(self.handle,\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/base.py\", line 246, in check_call\n raise get_last_ffi_error()\nmxnet.base.MXNetError: Traceback (most recent call last):\n File \"../src/storage/storage.cc\", line 97\nCUDA: Check failed: e == cudaSuccess || e == cudaErrorCudartUnloading: no CUDA-capable device is detected\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File \"/usr/local/lib/python3.8/dist-packages/flask/app.py\", line 1950, in full_dispatch_request\n rv = self.dispatch_request()\n File \"/usr/local/lib/python3.8/dist-packages/flask/app.py\", line 1936, in dispatch_request\n return self.view_functions[rule.endpoint](**req.view_args)\n File \"/app/ml/./src/services/flask_/needs_attached_file.py\", line 32, in wrapper\n return f(*args, **kwargs)\n File \"/app/ml/./src/_endpoints.py\", line 69, in find_faces_post\n faces = detector(\n File \"/app/ml/./src/services/facescan/plugins/mixins.py\", line 44, in __call__\n faces = self._fetch_faces(img, det_prob_threshold)\n File \"/app/ml/./src/services/facescan/plugins/mixins.py\", line 51, in _fetch_faces\n boxes = self.find_faces(img, det_prob_threshold)\n File \"/app/ml/./src/services/facescan/plugins/insightface/insightface.py\", line 83, in find_faces\n results = self._detection_model.get(img, det_thresh=det_prob_threshold)\n File \"/usr/local/lib/python3.8/dist-packages/cached_property.py\", line 36, in __get__\n value = obj.__dict__[self.func.__name__] = self.func(obj)\n File \"/app/ml/./src/services/facescan/plugins/insightface/insightface.py\", line 74, in _detection_model\n model.prepare(ctx_id=self._CTX_ID, nms=self._NMS)\n File \"/usr/local/lib/python3.8/dist-packages/insightface/app/face_analysis.py\", line 32, in prepare\n self.det_model.prepare(ctx_id, nms)\n File \"/usr/local/lib/python3.8/dist-packages/insightface/model_zoo/face_detection.py\", line 217, in prepare\n model.bind(data_shapes=[('data', data_shape)])\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/module/module.py\", line 422, in bind\n self._exec_group = DataParallelExecutorGroup(self._symbol, self._context,\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/module/executor_group.py\", line 280, in __init__\n self.bind_exec(data_shapes, label_shapes, shared_group)\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/module/executor_group.py\", line 383, in bind_exec\n self.execs.append(self._bind_ith_exec(i, data_shapes_i, label_shapes_i,\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/module/executor_group.py\", line 675, in _bind_ith_exec\n executor = self.symbol.simple_bind(ctx=context, grad_req=self.grad_req,\n File \"/usr/local/lib/python3.8/dist-packages/mxnet/symbol/symbol.py\", line 1944, in simple_bind\n raise RuntimeError(error_msg)\nRuntimeError: simple_bind error. Arguments:\ndata: (1, 3, 480, 640)\nTraceback (most recent call last):\n File \"../src/storage/storage.cc\", line 97\nCUDA: Check failed: e == cudaSuccess || e == cudaErrorCudartUnloading: no CUDA-capable device is detected\n", "build_version": "dev"}
Maybe pospielov/compreface-core:1.0.0-mobilenet-3xxx
isn't supposed to work on my card, but my other CUDA apps work fine and I've never gotten Compreface to work.
+-----------------------------------------------------------------------------+
| NVIDIA-SMI 470.129.06 Driver Version: 470.129.06 CUDA Version: 11.4 |
|-------------------------------+----------------------+----------------------+
| GPU Name Persistence-M| Bus-Id Disp.A | Volatile Uncorr. ECC |
| Fan Temp Perf Pwr:Usage/Cap| Memory-Usage | GPU-Util Compute M. |
| | | MIG M. |
|===============================+======================+======================|
| 0 NVIDIA GeForce ... Off | 00000000:03:00.0 Off | N/A |
| 47% 46C P0 22W / 130W | 1656MiB / 5936MiB | 1% Default |
| | | N/A |
+-------------------------------+----------------------+----------------------+
+-----------------------------------------------------------------------------+
| Processes: |
| GPU GI CI PID Type Process name GPU Memory |
| ID ID Usage |
|=============================================================================|
| 0 N/A N/A 7884 C python3 1477MiB |
| 0 N/A N/A 8383 C ffmpeg 175MiB |
+-----------------------------------------------------------------------------+
Hi, I pulled and ran your image on an RTX 3060 and below is the output I am getting. Am I meant to replace mobile net gpu core with this image or something to run the whole solution? As from previous testing I saw graphic card usage only starts during recognition, verification or detection process.
[uWSGI] getting INI configuration from uwsgi.ini
*** Starting uWSGI 2.0.19 (64bit) on [Thu May 26 07:58:07 2022] ***
compiled with version: 9.4.0 on 05 May 2022 14:03:34
os: Linux-5.13.0-41-generic #46~20.04.1-Ubuntu SMP Wed Apr 20 13:16:21 UTC 2022
nodename: df8786e4cda2
machine: x86_64
clock source: unix
detected number of CPU cores: 12
current working directory: /app/ml
detected binary path: /usr/local/bin/uwsgi
!!! no internal routing support, rebuild with pcre support !!!
setgid() to 33
setuid() to 33
your memory page size is 4096 bytes
detected max file descriptor number: 1048576
lock engine: pthread robust mutexes
thunder lock: disabled (you can enable it with --thunder-lock)
uwsgi socket 0 bound to TCP address 0.0.0.0:3000 fd 3
Python version: 3.8.10 (default, Mar 15 2022, 12:22:08) [GCC 9.4.0]
Python main interpreter initialized at 0x557305964620
python threads support enabled
your server socket listen backlog is limited to 100 connections
your mercy for graceful operations on workers is 60 seconds
mapped 145808 bytes (142 KB) for 1 cores
*** Operational MODE: single process ***
{"severity": "INFO", "message": "{'BUILD_VERSION': 'dev', 'CALCULATION_PLUGIN': 'insightface.Calculator@arcface_mobilefacenet', 'EXTRA_PLUGINS': ['insightface.Landmarks2d106Detector', 'insightface.GenderDetector', 'insightface.AgeDetector', 'insightface.facemask.MaskDetector'], 'FACE_DETECTION_PLUGIN': 'insightface.FaceDetector@retinaface_mnet025_v1', 'GPU_IDX': 0, 'IMG_LENGTH_LIMIT': 640, 'INTEL_OPTIMIZATION': False, 'IS_DEV_ENV': False, 'LOGGING_LEVEL_NAME': 'DEBUG', 'ML_PORT': 3000}", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Creating new app for WSGI", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
WSGI app 0 (mountpoint='') ready in 1 seconds on interpreter 0x557305964620 pid: 1 (default app)
*** uWSGI is running in multiple interpreter mode ***
spawned uWSGI master process (pid: 1)
spawned uWSGI worker 1 (pid: 30, cores: 1)
Thu May 26 15:58:36 2022
+-----------------------------------------------------------------------------+
| NVIDIA-SMI 510.73.05 Driver Version: 510.73.05 CUDA Version: 11.6 |
|-------------------------------+----------------------+----------------------+
| GPU Name Persistence-M| Bus-Id Disp.A | Volatile Uncorr. ECC |
| Fan Temp Perf Pwr:Usage/Cap| Memory-Usage | GPU-Util Compute M. |
| | | MIG M. |
|===============================+======================+======================|
| 0 NVIDIA GeForce ... Off | 00000000:01:00.0 On | N/A |
| N/A 46C P8 14W / N/A | 77MiB / 6144MiB | 14% Default |
| | | N/A |
+-------------------------------+----------------------+----------------------+
+-----------------------------------------------------------------------------+
| Processes: |
| GPU GI CI PID Type Process name GPU Memory |
| ID ID Usage |
|=============================================================================|
| 0 N/A N/A 1194 G /usr/lib/xorg/Xorg 22MiB |
| 0 N/A N/A 2721 G /usr/lib/xorg/Xorg 53MiB |
+-----------------------------------------------------------------------------+
@nagem07 Here is the configuration:
3xxx.zip
All you need is to unarchive, run with docker-compose up -d
, and test any service, e.g. detection
@mister2d CompreFace should work well on GTX 1660. The problem affects only GPU from 3xxx series. Do you use the config downloaded from this repository? Do you have more than one GPU?
I composed the configuration file you provided and tested all three services, recognition service return an error "Something went wrong, please try again later.", while verification seems to be stuck in an infinite loop. However, detection, returns the bounding box and data such as age and gender but without any bounding box on the image itself. I am attaching a screenshot as well as logs below for you.
FE
/docker-entrypoint.sh: /docker-entrypoint.d/ is not empty, will attempt to perform configuration
/docker-entrypoint.sh: Looking for shell scripts in /docker-entrypoint.d/
/docker-entrypoint.sh: Launching /docker-entrypoint.d/10-listen-on-ipv6-by-default.sh
10-listen-on-ipv6-by-default.sh: info: /etc/nginx/conf.d/default.conf is not a file or does not exist
/docker-entrypoint.sh: Launching /docker-entrypoint.d/20-envsubst-on-templates.sh
/docker-entrypoint.sh: Launching /docker-entrypoint.d/30-tune-worker-processes.sh
/docker-entrypoint.sh: Configuration complete; ready for start up
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET / HTTP/1.1" 200 1076 "-" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /styles.806ac3d3e467ca8213dc.css HTTP/1.1" 200 12114 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /polyfills-es2015.2da5f783f714f4c0074e.js HTTP/1.1" 200 12537 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /runtime-es2015.f475d5a6b7ebcbca32dc.js HTTP/1.1" 200 1340 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /main-es2015.fb4bea5b907e4dbd64ea.js HTTP/1.1" 200 226910 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /assets/i18n/en.json HTTP/1.1" 200 2571 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /favicon.ico HTTP/1.1" 200 10313 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /admin/user/me HTTP/1.1" 401 113 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:35 +0000] "GET /assets/img/face-recognition-logo.svg HTTP/1.1" 200 7076 "http://localhost:8000/login?redirect=%2F" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:37 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/login?redirect=%2F" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:37 +0000] "GET /admin/user/demo/model HTTP/1.1" 200 52 "http://localhost:8000/login?redirect=%2F" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:42 +0000] "GET /11-es2015.f3db429c0ff2486cdaf8.js HTTP/1.1" 200 6793 "http://localhost:8000/login?redirect=%2F" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:42 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/sign-up" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:17:42 +0000] "GET /admin/user/demo/model HTTP/1.1" 200 52 "http://localhost:8000/sign-up" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:08 +0000] "POST /admin/user/register HTTP/1.1" 201 0 "http://localhost:8000/sign-up" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:08 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/login" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:08 +0000] "GET /admin/user/demo/model HTTP/1.1" 404 95 "http://localhost:8000/login" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - CommonClientId [27/May/2022:02:18:14 +0000] "POST /admin/oauth/token HTTP/1.1" 200 0 "http://localhost:8000/login" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/login" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/face-recognition-logo-mobile.svg HTTP/1.1" 200 1874 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/icons/search.svg HTTP/1.1" 200 379 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/icons/add_new.svg HTTP/1.1" 200 377 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/icons/info_new.svg HTTP/1.1" 200 386 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/icons/edit.svg HTTP/1.1" 200 344 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:14 +0000] "GET /assets/img/icons/trash.svg HTTP/1.1" 200 407 "http://localhost:8000/" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /assets/img/icons/copy.svg HTTP/1.1" 200 466 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:16 +0000] "GET /assets/img/icons/more-vert_new.svg HTTP/1.1" 200 254 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:19 +0000] "GET /assets/img/icons/upload.svg HTTP/1.1" 200 298 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:19 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:19 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:23 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:23 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:23 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:23 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:25 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:25 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:28 +0000] "GET /assets/img/icons/body-scan.svg HTTP/1.1" 200 665 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:18:37 +0000] "POST /api/v1/verification/verify?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 200 254 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:36 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:36 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:36 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:36 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:37 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:37 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:41 +0000] "POST /api/v1/recognition/recognize?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 400 83 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:49 +0000] "POST /api/v1/recognition/recognize?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 400 83 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:50 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:50 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:50 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:50 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:52 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000003&type=DETECTION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:52 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000003&type=DETECTION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:20:55 +0000] "POST /api/v1/detection/detect?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 200 185 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000003&type=DETECTION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:21:54 +0000] "POST /api/v1/detection/detect?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 200 185 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000003&type=DETECTION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:21:57 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:21:57 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:21:57 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:21:57 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:00 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:00 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000004&type=VERIFY" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:02 +0000] "GET /admin/user/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:02 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/models HTTP/1.1" 200 146 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:02 +0000] "GET /admin/app/00000000-0000-0000-0000-000000000001/roles HTTP/1.1" 200 147 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:02 +0000] "GET /api/v1/consistence/status HTTP/1.1" 200 105 "http://localhost:8000/application?app=00000000-0000-0000-0000-000000000001" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:03 +0000] "GET /admin/user/me HTTP/1.1" 200 132 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:03 +0000] "GET /admin/apps HTTP/1.1" 200 173 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:05 +0000] "POST /api/v1/recognition/recognize?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 400 83 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
172.18.0.1 - - [27/May/2022:02:22:53 +0000] "POST /api/v1/recognition/recognize?face_plugins=landmarks&face_plugins=gender&face_plugins=age HTTP/1.1" 400 83 "http://localhost:8000/test-model?app=00000000-0000-0000-0000-000000000001&model=00000000-0000-0000-0000-000000000001&type=RECOGNITION" "Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:99.0) Gecko/20100101 Firefox/99.0"
Admin
Listening for transport dt_socket at address: 5005
2022-05-27 02:16:40.036 INFO 7 --- [kground-preinit] o.h.validator.internal.util.Version : HV000001: Hibernate Validator 6.1.5.Final
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v2.3.4.RELEASE)
2022-05-27 02:16:41.308 INFO 7 --- [ main] com.exadel.frs.FrsApplication : The following profiles are active: dev
2022-05-27 02:16:44.553 INFO 7 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFERRED mode.
2022-05-27 02:16:44.862 INFO 7 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 289ms. Found 10 JPA repository interfaces.
2022-05-27 02:16:45.622 INFO 7 --- [ main] o.s.cloud.context.scope.GenericScope : BeanFactory id=e7f41a96-3f70-3efd-b7dc-40aa4699bf29
2022-05-27 02:16:45.839 INFO 7 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'com.exadel.frs.commonservice.system.feign.ApperyStatisticsClient' of type [org.springframework.cloud.openfeign.FeignClientFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2022-05-27 02:16:46.765 INFO 7 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 8080 (http)
2022-05-27 02:16:46.778 INFO 7 --- [ main] o.a.coyote.http11.Http11NioProtocol : Initializing ProtocolHandler ["http-nio-8080"]
2022-05-27 02:16:46.779 INFO 7 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-05-27 02:16:46.779 INFO 7 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.38]
2022-05-27 02:16:46.861 INFO 7 --- [ main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-05-27 02:16:46.861 INFO 7 --- [ main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 5504 ms
2022-05-27 02:16:47.316 INFO 7 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2022-05-27 02:16:47.563 INFO 7 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Start completed.
2022-05-27 02:16:48.847 INFO 7 --- [ main] liquibase.lockservice : Successfully acquired change log lock
2022-05-27 02:16:49.677 INFO 7 --- [ main] liquibase.changelog : Creating database history table with name: public.databasechangelog
2022-05-27 02:16:49.782 INFO 7 --- [ main] liquibase.changelog : Reading from public.databasechangelog
2022-05-27 02:16:50.134 INFO 7 --- [ main] liquibase.lockservice : Successfully released change log lock
2022-05-27 02:16:50.145 INFO 7 --- [ main] liquibase.lockservice : Successfully acquired change log lock
Skipping auto-registration
2022-05-27 02:16:50.146 WARN 7 --- [ main] liquibase.hub : Skipping auto-registration
2022-05-27 02:16:50.179 INFO 7 --- [ main] liquibase.changelog : Custom SQL executed
2022-05-27 02:16:50.225 INFO 7 --- [ main] liquibase.changelog : Table user created
2022-05-27 02:16:50.303 INFO 7 --- [ main] liquibase.changelog : Primary key added to user (id)
2022-05-27 02:16:50.304 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.email
2022-05-27 02:16:50.305 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.password
2022-05-27 02:16:50.305 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.first_name
2022-05-27 02:16:50.306 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.last_name
2022-05-27 02:16:50.306 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.guid
2022-05-27 02:16:50.306 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.account_non_expired
2022-05-27 02:16:50.307 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.account_non_locked
2022-05-27 02:16:50.307 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.credentials_non_expired
2022-05-27 02:16:50.308 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user.enabled
2022-05-27 02:16:50.308 INFO 7 --- [ main] liquibase.changelog : Sequence user_id_seq created
2022-05-27 02:16:50.359 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to user(email)
2022-05-27 02:16:50.415 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to user(guid)
2022-05-27 02:16:50.436 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.1.yaml::create-user-table::Andrei Hayeuski ran successfully in 278ms
2022-05-27 02:16:50.450 INFO 7 --- [ main] liquibase.changelog : Table organization created
2022-05-27 02:16:50.450 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to organization.name
2022-05-27 02:16:50.451 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to organization.guid
2022-05-27 02:16:50.525 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to organization(name)
2022-05-27 02:16:50.583 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to organization(guid)
2022-05-27 02:16:50.627 INFO 7 --- [ main] liquibase.changelog : Primary key added to organization (id)
2022-05-27 02:16:50.628 INFO 7 --- [ main] liquibase.changelog : Sequence organization_id_seq created
2022-05-27 02:16:50.629 INFO 7 --- [ main] liquibase.changelog : New row inserted into organization
2022-05-27 02:16:50.658 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.2.yaml::create-organization-table::Andrei Hayeuski ran successfully in 210ms
2022-05-27 02:16:50.671 INFO 7 --- [ main] liquibase.changelog : Table app created
2022-05-27 02:16:50.672 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to app.name
2022-05-27 02:16:50.672 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to app.guid
2022-05-27 02:16:50.673 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to app.organization_id
2022-05-27 02:16:50.673 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to app.api_key
2022-05-27 02:16:50.739 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to app(name, organization_id)
2022-05-27 02:16:50.806 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to app(api_key)
2022-05-27 02:16:50.862 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to app(guid)
2022-05-27 02:16:50.895 INFO 7 --- [ main] liquibase.changelog : Primary key added to app (id)
2022-05-27 02:16:50.902 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to app (organization_id)
2022-05-27 02:16:50.903 INFO 7 --- [ main] liquibase.changelog : Sequence app_id_seq created
2022-05-27 02:16:50.925 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.3.yaml::create-app-table::Andrei Hayeuski ran successfully in 255ms
2022-05-27 02:16:50.938 INFO 7 --- [ main] liquibase.changelog : Table model created
2022-05-27 02:16:51.014 INFO 7 --- [ main] liquibase.changelog : Primary key added to model (id)
2022-05-27 02:16:51.016 INFO 7 --- [ main] liquibase.changelog : Sequence model_id_seq created
2022-05-27 02:16:51.017 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to model.name
2022-05-27 02:16:51.019 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to model.guid
2022-05-27 02:16:51.020 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to model.app_id
2022-05-27 02:16:51.021 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to model.api_key
2022-05-27 02:16:51.096 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to model(name, app_id)
2022-05-27 02:16:51.141 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to model(api_key)
2022-05-27 02:16:51.186 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to model(guid)
2022-05-27 02:16:51.190 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to model (app_id)
2022-05-27 02:16:51.214 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.4.yaml::create-model-table::Andrei Hayeuski ran successfully in 277ms
2022-05-27 02:16:51.230 INFO 7 --- [ main] liquibase.changelog : Table app_model created
2022-05-27 02:16:51.297 INFO 7 --- [ main] liquibase.changelog : Primary key added to app_model (app_id, model_id)
2022-05-27 02:16:51.299 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to app_model (app_id)
2022-05-27 02:16:51.300 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to app_model (model_id)
2022-05-27 02:16:51.301 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to app_model.access_type
2022-05-27 02:16:51.336 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.5.yaml::create-app_model-table::Andrei Hayeuski ran successfully in 110ms
2022-05-27 02:16:51.352 INFO 7 --- [ main] liquibase.changelog : Table user_app_role created
2022-05-27 02:16:51.409 INFO 7 --- [ main] liquibase.changelog : Primary key added to user_app_role (app_id, user_id)
2022-05-27 02:16:51.411 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user_app_role.role
2022-05-27 02:16:51.414 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to user_app_role (app_id)
2022-05-27 02:16:51.417 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to user_app_role (user_id)
2022-05-27 02:16:51.447 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.6.yaml::create-user_app_role-table::Andrei Hayeuski ran successfully in 99ms
2022-05-27 02:16:51.463 INFO 7 --- [ main] liquibase.changelog : Table user_organization_role created
2022-05-27 02:16:51.520 INFO 7 --- [ main] liquibase.changelog : Primary key added to user_organization_role (organization_id, user_id)
2022-05-27 02:16:51.522 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to user_organization_role.role
2022-05-27 02:16:51.525 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to user_organization_role (organization_id)
2022-05-27 02:16:51.528 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to user_organization_role (user_id)
2022-05-27 02:16:51.558 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.7.yaml::create-user_organization_role-table::Andrei Hayeuski ran successfully in 99ms
2022-05-27 02:16:51.631 INFO 7 --- [ main] liquibase.changelog : Table oauth_refresh_token created
2022-05-27 02:16:51.723 INFO 7 --- [ main] liquibase.changelog : Table oauth_access_token created
2022-05-27 02:16:51.768 INFO 7 --- [ main] liquibase.changelog : Primary key added to oauth_access_token (authentication_id)
2022-05-27 02:16:51.812 INFO 7 --- [ main] liquibase.changelog : Table oauth_client_details created
2022-05-27 02:16:51.868 INFO 7 --- [ main] liquibase.changelog : Primary key added to oauth_client_details (client_id)
2022-05-27 02:16:51.872 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to oauth_client_details.client_id
2022-05-27 02:16:51.873 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to oauth_client_details.authorities
2022-05-27 02:16:51.875 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to oauth_client_details.authorized_grant_types
2022-05-27 02:16:51.876 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to oauth_client_details.resource_ids
2022-05-27 02:16:51.878 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to oauth_client_details.scope
2022-05-27 02:16:51.914 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.8.yaml::create-security-oauth2-tables::Dmitry Andryianau ran successfully in 344ms
2022-05-27 02:16:51.930 INFO 7 --- [ main] liquibase.changelog : Table model_share_request created
2022-05-27 02:16:52.001 INFO 7 --- [ main] liquibase.changelog : Primary key added to model_share_request (app_id, request_id)
2022-05-27 02:16:52.002 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to model_share_request (app_id)
2022-05-27 02:16:52.036 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.0.9.yaml::create-model_share_request-table::Valijon Sobirov ran successfully in 110ms
2022-05-27 02:16:52.113 INFO 7 --- [ main] liquibase.changelog : Table face created
2022-05-27 02:16:52.191 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to face(id)
2022-05-27 02:16:52.195 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to face (api_key)
2022-05-27 02:16:52.214 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.0.yaml::create-face-table::Maryna Misachenka ran successfully in 167ms
2022-05-27 02:16:52.292 INFO 7 --- [ main] liquibase.changelog : Table image created
2022-05-27 02:16:52.296 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to image (face_id)
2022-05-27 02:16:52.325 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.1.yaml::create-image-table::Maryna Misachenka ran successfully in 99ms
2022-05-27 02:16:52.341 INFO 7 --- [ main] liquibase.changelog : New row inserted into app
2022-05-27 02:16:52.343 INFO 7 --- [ main] liquibase.changelog : New row inserted into model
2022-05-27 02:16:52.346 INFO 7 --- [ main] liquibase.changelog : New row inserted into user
2022-05-27 02:16:52.348 INFO 7 --- [ main] liquibase.changelog : New row inserted into user_app_role
2022-05-27 02:16:52.351 INFO 7 --- [ main] liquibase.changelog : New row inserted into user_organization_role
2022-05-27 02:16:52.357 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.359 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.364 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.366 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.371 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.373 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.378 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.379 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.385 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.386 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.391 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.393 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.398 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.399 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.404 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.405 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.410 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.411 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.416 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.417 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.422 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.423 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.428 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.429 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.434 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.435 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.439 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.440 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.444 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.444 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.447 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.447 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.450 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.450 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.452 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.453 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.455 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.455 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.457 INFO 7 --- [ main] liquibase.changelog : New row inserted into face
2022-05-27 02:16:52.458 INFO 7 --- [ main] liquibase.changelog : New row inserted into image
2022-05-27 02:16:52.470 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.2.yaml::add-demo-data::Andrei Hayeuski ran successfully in 133ms
2022-05-27 02:16:52.485 INFO 7 --- [ main] liquibase.changelog : Table organization dropped
2022-05-27 02:16:52.486 INFO 7 --- [ main] liquibase.changelog : Columns global_role(varchar(1)) added to user
2022-05-27 02:16:52.489 INFO 7 --- [ main] liquibase.changelog : Custom SQL executed
2022-05-27 02:16:52.491 INFO 7 --- [ main] liquibase.changelog : Table user_organization_role dropped
2022-05-27 02:16:52.492 INFO 7 --- [ main] liquibase.changelog : Columns organization_id dropped from app
2022-05-27 02:16:52.504 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.3.yaml::update-without-organization::Andrei Zelikov ran successfully in 22ms
2022-05-27 02:16:52.518 INFO 7 --- [ main] liquibase.changelog : Columns type(varchar(1)) added to model
2022-05-27 02:16:52.520 INFO 7 --- [ main] liquibase.changelog : Custom SQL executed
2022-05-27 02:16:52.522 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to model.type
2022-05-27 02:16:52.526 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.4.yaml::model-type-column::Aliaksandr Pleski ran successfully in 10ms
2022-05-27 02:16:52.541 INFO 7 --- [ main] liquibase.changelog : Columns allow_statistics(boolean) added to user
2022-05-27 02:16:52.548 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.5.yaml::update-without-organization::Aleksand Kurilo ran successfully in 10ms
2022-05-27 02:16:52.563 INFO 7 --- [ main] liquibase.changelog : Table model_share_request dropped
2022-05-27 02:16:52.571 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.6.yaml::drop-model-share-request-table::Eugene Savko ran successfully in 11ms
2022-05-27 02:16:52.586 INFO 7 --- [ main] liquibase.changelog : Table install_info created
2022-05-27 02:16:52.647 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to install_info(install_guid)
2022-05-27 02:16:52.650 INFO 7 --- [ main] liquibase.changelog : Custom SQL executed
2022-05-27 02:16:52.681 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.6.yaml::create-organization-table::Pavel Nikolaichik ran successfully in 99ms
2022-05-27 02:16:52.696 INFO 7 --- [ main] liquibase.changelog : Columns migrated(boolean) added to face
2022-05-27 02:16:52.704 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.7.yaml::prepare-faces-to-migration::sshimansky@exadel.com ran successfully in 9ms
2022-05-27 02:16:52.719 INFO 7 --- [ main] liquibase.changelog : Table subject created
2022-05-27 02:16:52.781 INFO 7 --- [ main] liquibase.changelog : Primary key added to subject (id)
2022-05-27 02:16:52.859 INFO 7 --- [ main] liquibase.changelog : Unique constraint added to subject(api_key, subject_name)
2022-05-27 02:16:52.863 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to subject (api_key)
2022-05-27 02:16:52.893 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.7.yaml::create-subject-table::sshimansky@exadel.com ran successfully in 176ms
2022-05-27 02:16:52.971 INFO 7 --- [ main] liquibase.changelog : Table img created
2022-05-27 02:16:53.048 INFO 7 --- [ main] liquibase.changelog : Primary key added to img (id)
2022-05-27 02:16:53.050 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to img.content
2022-05-27 02:16:53.059 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.7.yaml::create-img-table::sshimansky@exadel.com ran successfully in 154ms
2022-05-27 02:16:53.149 INFO 7 --- [ main] liquibase.changelog : Table embedding created
2022-05-27 02:16:53.151 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to embedding.calculator
2022-05-27 02:16:53.152 INFO 7 --- [ main] liquibase.changelog : NOT NULL constraint has been added to embedding.embedding
2022-05-27 02:16:53.194 INFO 7 --- [ main] liquibase.changelog : Primary key added to embedding (id)
2022-05-27 02:16:53.197 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to embedding (subject_id)
2022-05-27 02:16:53.200 INFO 7 --- [ main] liquibase.changelog : Foreign key constraint added to embedding (img_id)
2022-05-27 02:16:53.226 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.7.yaml::create-embedding-table::sshimansky@exadel.com ran successfully in 155ms
2022-05-27 02:16:53.487 INFO 7 --- [ main] o.s.s.concurrent.ThreadPoolTaskExecutor : Initializing ExecutorService 'applicationTaskExecutor'
2022-05-27 02:16:53.502 INFO 7 --- [ main] o.s.s.c.ThreadPoolTaskScheduler : Initializing ExecutorService 'taskScheduler'
2022-05-27 02:16:53.623 INFO 7 --- [ task-1] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: default]
2022-05-27 02:16:53.812 INFO 7 --- [ task-1] org.hibernate.Version : HHH000412: Hibernate ORM core version 5.4.21.Final
2022-05-27 02:16:54.265 INFO 7 --- [ task-1] o.hibernate.annotations.common.Version : HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
2022-05-27 02:16:54.664 INFO 7 --- [ task-1] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL10Dialect
2022-05-27 02:16:55.324 WARN 7 --- [ task-1] Hibernate Types : You should use Hypersistence Optimizer to speed up your Hibernate application!
2022-05-27 02:16:55.324 WARN 7 --- [ task-1] Hibernate Types : For more details, go to https://vladmihalcea.com/hypersistence-optimizer/
2022-05-27 02:16:55.325 INFO 7 --- [ task-1] Hibernate Types :
_ _ _ _
| | | | (_) | |
| |__| |_ _ _ __ ___ _ __ ___ _ ___| |_ ___ _ __ ___ ___
| __ | | | | '_ \ / _ \ '__/ __| / __| __/ _ \ '_ \ / __/ _ \
| | | | |_| | |_) | __/ | \__ \ \__ \ || __/ | | | (_| __/
|_| |_|\__, | .__/ \___|_| |___/_|___/\__\___|_| |_|\___\___|
__/ | |
|___/|_|
____ _ _ _
/ __ \ | | (_) (_)
| | | |_ __ | |_ _ _ __ ___ _ _______ _ __
| | | | '_ \| __| | '_ ` _ \| |_ / _ \ '__|
| |__| | |_) | |_| | | | | | | |/ / __/ |
\____/| .__/ \__|_|_| |_| |_|_/___\___|_|
| |
|_|
2022-05-27 02:16:55.325 INFO 7 --- [ task-1] Hibernate Types : Check out the README page for more info about the Hypersistence Optimizer banner https://github.com/vladmihalcea/hibernate-types#how-to-remove-the-hypersistence-optimizer-banner-from-the-log
2022-05-27 02:16:57.031 INFO 7 --- [ task-1] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-05-27 02:16:57.058 INFO 7 --- [ task-1] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default'
2022-05-27 02:16:57.222 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000010
2022-05-27 02:16:57.265 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 1 face(s) done
2022-05-27 02:16:57.266 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000011
2022-05-27 02:16:57.275 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 2 face(s) done
2022-05-27 02:16:57.276 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000012
2022-05-27 02:16:57.286 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 3 face(s) done
2022-05-27 02:16:57.287 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000013
2022-05-27 02:16:57.297 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 4 face(s) done
2022-05-27 02:16:57.298 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000014
2022-05-27 02:16:57.308 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 5 face(s) done
2022-05-27 02:16:57.309 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000015
2022-05-27 02:16:57.319 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 6 face(s) done
2022-05-27 02:16:57.320 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000016
2022-05-27 02:16:57.331 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 7 face(s) done
2022-05-27 02:16:57.331 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000017
2022-05-27 02:16:57.342 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 8 face(s) done
2022-05-27 02:16:57.342 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000018
2022-05-27 02:16:57.353 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 9 face(s) done
2022-05-27 02:16:57.354 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000019
2022-05-27 02:16:57.364 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 10 face(s) done
2022-05-27 02:16:57.365 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000020
2022-05-27 02:16:57.375 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 11 face(s) done
2022-05-27 02:16:57.376 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000022
2022-05-27 02:16:57.386 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 12 face(s) done
2022-05-27 02:16:57.387 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000023
2022-05-27 02:16:57.397 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 13 face(s) done
2022-05-27 02:16:57.398 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000024
2022-05-27 02:16:57.409 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 14 face(s) done
2022-05-27 02:16:57.409 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000025
2022-05-27 02:16:57.419 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 15 face(s) done
2022-05-27 02:16:57.421 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000026
2022-05-27 02:16:57.431 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 16 face(s) done
2022-05-27 02:16:57.432 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000027
2022-05-27 02:16:57.442 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 17 face(s) done
2022-05-27 02:16:57.443 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000028
2022-05-27 02:16:57.453 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 18 face(s) done
2022-05-27 02:16:57.454 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000029
2022-05-27 02:16:57.464 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 19 face(s) done
2022-05-27 02:16:57.465 DEBUG 7 --- [ main] c.e.f.c.s.l.TransactionalFaceMigration : Inserted subject with id 00000000-0000-0000-0000-000000000021
2022-05-27 02:16:57.475 DEBUG 7 --- [ main] f.c.s.l.FacesToSubjectMigrationProcessor : 20 face(s) done
2022-05-27 02:16:57.477 INFO 7 --- [ main] c.e.f.c.s.l.FacesToSubjectsMigration : Migrated 20 faces in 4233ms
2022-05-27 02:16:57.477 INFO 7 --- [ main] liquibase.changelog : ok
2022-05-27 02:16:57.477 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.7.yaml::migrate-face-image::sshimansky@exadel.com ran successfully in 4239ms
2022-05-27 02:16:57.489 INFO 7 --- [ main] liquibase.changelog : New row inserted into model
2022-05-27 02:16:57.489 INFO 7 --- [ main] liquibase.changelog : New row inserted into model
2022-05-27 02:16:57.498 INFO 7 --- [ main] liquibase.changelog : ChangeSet db/changelog/db.changelog-0.1.8.yaml::add-detection-verification-services::Shreyansh Sancheti ran successfully in 11ms
2022-05-27 02:16:57.520 INFO 7 --- [ main] liquibase.lockservice : Successfully released change log lock
2022-05-27 02:16:58.208 INFO 7 --- [ main] DeferredRepositoryInitializationListener : Triggering deferred initialization of Spring Data repositories…
2022-05-27 02:16:59.573 INFO 7 --- [ main] DeferredRepositoryInitializationListener : Spring Data repositories initialized!
2022-05-27 02:17:00.160 INFO 7 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 2 endpoint(s) beneath base path '/actuator'
2022-05-27 02:17:00.327 INFO 7 --- [ main] pertySourcedRequestMappingHandlerMapping : Mapped URL path [/v2/api-docs] onto method [springfox.documentation.swagger2.web.Swagger2Controller#getDocumentation(String, HttpServletRequest)]
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/v2/api-docs'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/configuration/ui'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/swagger-resources/**'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/configuration/**'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/swagger-ui**'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/webjars/**'], []
2022-05-27 02:17:01.473 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: Ant [pattern='/lms/**'], []
2022-05-27 02:17:01.560 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: OrRequestMatcher [requestMatchers=[Ant [pattern='/oauth/token'], Ant [pattern='/oauth/token_key'], Ant [pattern='/oauth/check_token']]], [org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@b671dda, org.springframework.security.web.context.SecurityContextPersistenceFilter@6d7556a8, org.springframework.security.web.header.HeaderWriterFilter@3292eff7, org.springframework.security.web.authentication.logout.LogoutFilter@7a021f49, org.springframework.security.web.authentication.www.BasicAuthenticationFilter@1bcb8599, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@7e0883f3, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@97b84a4, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@25b20860, org.springframework.security.web.session.SessionManagementFilter@d677be9, org.springframework.security.web.access.ExceptionTranslationFilter@c6244e7, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@515940af]
2022-05-27 02:17:01.588 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: org.springframework.security.oauth2.config.annotation.web.configuration.ResourceServerConfiguration$NotOAuthRequestMatcher@656c5818, [org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@3e2578ea, org.springframework.security.web.context.SecurityContextPersistenceFilter@3a13f663, org.springframework.security.web.header.HeaderWriterFilter@4aa517c3, org.springframework.security.web.authentication.logout.LogoutFilter@59014efe, org.springframework.security.oauth2.provider.authentication.OAuth2AuthenticationProcessingFilter@983050b, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@75de7009, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@17a77a7e, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@29592929, org.springframework.security.web.session.SessionManagementFilter@5f369fc6, org.springframework.security.web.access.ExceptionTranslationFilter@11dbcb3b, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@21688427]
2022-05-27 02:17:01.594 INFO 7 --- [ main] o.s.s.web.DefaultSecurityFilterChain : Creating filter chain: any request, [org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@780546f8, org.springframework.security.web.context.SecurityContextPersistenceFilter@aa23f11, org.springframework.security.web.header.HeaderWriterFilter@303fbc4, org.springframework.security.web.authentication.logout.LogoutFilter@6614ecca, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@65a80fdb, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@79e90571, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@b3004e, org.springframework.security.web.session.SessionManagementFilter@4cd90c36, org.springframework.security.web.access.ExceptionTranslationFilter@774304ca, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@75663443]
2022-05-27 02:17:04.876 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2022-05-27 02:17:04.897 INFO 7 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2022-05-27 02:17:04.897 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2022-05-27 02:17:04.902 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Using db table-based data access locking (synchronization).
2022-05-27 02:17:04.906 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : JobStoreCMT initialized.
2022-05-27 02:17:04.907 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Scheduler meta-data: Quartz Scheduler (v2.3.2) 'statistics scheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 1 threads.
Using job-store 'org.springframework.scheduling.quartz.LocalDataSourceJobStore' - which supports persistence. and is not clustered.
2022-05-27 02:17:04.907 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'statistics scheduler' initialized from an externally provided properties instance.
2022-05-27 02:17:04.907 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2022-05-27 02:17:04.907 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: org.springframework.scheduling.quartz.SpringBeanJobFactory@571db8b4
2022-05-27 02:17:04.960 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Freed 0 triggers from 'acquired' / 'blocked' state.
2022-05-27 02:17:04.962 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Recovering 0 jobs that were in-progress at the time of the last shut-down.
2022-05-27 02:17:04.962 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Recovery complete.
2022-05-27 02:17:04.963 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Removed 0 'complete' triggers.
2022-05-27 02:17:04.963 INFO 7 --- [ main] o.s.s.quartz.LocalDataSourceJobStore : Removed 0 stale fired job entries.
2022-05-27 02:17:04.967 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Scheduler statistics scheduler_$_NON_CLUSTERED started.
2022-05-27 02:17:04.990 WARN 7 --- [ main] c.n.c.sources.URLConfigurationSource : No URLs will be polled as dynamic configuration sources.
2022-05-27 02:17:04.991 INFO 7 --- [ main] c.n.c.sources.URLConfigurationSource : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2022-05-27 02:17:05.003 WARN 7 --- [ main] c.n.c.sources.URLConfigurationSource : No URLs will be polled as dynamic configuration sources.
2022-05-27 02:17:05.003 INFO 7 --- [ main] c.n.c.sources.URLConfigurationSource : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2022-05-27 02:17:05.543 INFO 7 --- [ main] o.a.coyote.http11.Http11NioProtocol : Starting ProtocolHandler ["http-nio-8080"]
2022-05-27 02:17:05.563 INFO 7 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 8080 (http) with context path ''
2022-05-27 02:17:05.564 INFO 7 --- [ main] d.s.w.p.DocumentationPluginsBootstrapper : Context refreshed
2022-05-27 02:17:05.600 INFO 7 --- [ main] d.s.w.p.DocumentationPluginsBootstrapper : Found 1 custom documentation plugin(s)
2022-05-27 02:17:05.667 INFO 7 --- [ main] s.d.s.w.s.ApiListingReferenceScanner : Scanning for api listing references
2022-05-27 02:17:05.864 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: regenerateApiKeyUsingPUT_1
2022-05-27 02:17:05.913 INFO 7 --- [ main] DeferredRepositoryInitializationListener : Triggering deferred initialization of Spring Data repositories…
2022-05-27 02:17:05.913 INFO 7 --- [ main] DeferredRepositoryInitializationListener : Spring Data repositories initialized!
2022-05-27 02:17:05.934 INFO 7 --- [ main] com.exadel.frs.FrsApplication : Started FrsApplication in 27.387 seconds (JVM running for 28.456)
2022-05-27 02:17:35.684 INFO 7 --- [nio-8080-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2022-05-27 02:17:35.684 INFO 7 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2022-05-27 02:17:35.694 INFO 7 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 9 ms
2022-05-27 02:18:08.116 INFO 7 --- [nio-8080-exec-4] com.exadel.frs.service.UserService : Demo user update with userCreateDto: UserCreateDto(email=nagesh@emerico.com, firstName=Nagesh, lastName=Ardjoon, password=testing1212!, isAllowStatistics=false)
2022-05-27 02:18:08.266 INFO 7 --- [nio-8080-exec-4] c.e.f.c.a.StatisticsCollectionAspect : Request to send statistics in background
2022-05-27 02:18:08.268 INFO 7 --- [nio-8080-exec-4] c.e.f.c.a.StatisticsCollectionAspect : Statistic is disabled by user, statistics wasn't send
2022-05-27 02:18:14.357 INFO 7 --- [nio-8080-exec-6] o.s.s.o.p.token.store.JdbcTokenStore : Failed to find access token for token 7d66525f-4a31-4ae3-955d-b1cd4839983b
API
Listening for transport dt_socket at address: 5005
2022-05-27 02:16:35.588 INFO 7 --- [kground-preinit] o.h.validator.internal.util.Version : HV000001: Hibernate Validator 6.1.5.Final
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v2.3.4.RELEASE)
2022-05-27 02:16:35.958 INFO 7 --- [ main] com.exadel.frs.TrainServiceApplication : The following profiles are active: dev
2022-05-27 02:16:36.836 INFO 7 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-05-27 02:16:36.951 INFO 7 --- [ main] .s.d.r.c.RepositoryConfigurationDelegate : Finished Spring Data repository scanning in 104ms. Found 6 JPA repository interfaces.
2022-05-27 02:16:37.454 INFO 7 --- [ main] o.s.cloud.context.scope.GenericScope : BeanFactory id=205fcd5f-0d69-3b59-9454-33cf48b1f0e2
2022-05-27 02:16:37.522 INFO 7 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'com.exadel.frs.commonservice.system.feign.ApperyStatisticsClient' of type [org.springframework.cloud.openfeign.FeignClientFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2022-05-27 02:16:37.829 INFO 7 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'cacheConfig' of type [com.exadel.frs.core.trainservice.config.CacheConfig$$EnhancerBySpringCGLIB$$3365f64c] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
2022-05-27 02:16:38.194 INFO 7 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat initialized with port(s): 8080 (http)
2022-05-27 02:16:38.223 INFO 7 --- [ main] o.a.coyote.http11.Http11NioProtocol : Initializing ProtocolHandler ["http-nio-8080"]
2022-05-27 02:16:38.223 INFO 7 --- [ main] o.apache.catalina.core.StandardService : Starting service [Tomcat]
2022-05-27 02:16:38.223 INFO 7 --- [ main] org.apache.catalina.core.StandardEngine : Starting Servlet engine: [Apache Tomcat/9.0.38]
2022-05-27 02:16:38.290 INFO 7 --- [ main] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring embedded WebApplicationContext
2022-05-27 02:16:38.290 INFO 7 --- [ main] w.s.c.ServletWebServerApplicationContext : Root WebApplicationContext: initialization completed in 2307 ms
2022-05-27 02:16:38.711 INFO 7 --- [ main] o.hibernate.jpa.internal.util.LogHelper : HHH000204: Processing PersistenceUnitInfo [name: default]
2022-05-27 02:16:38.834 INFO 7 --- [ main] org.hibernate.Version : HHH000412: Hibernate ORM core version 5.4.21.Final
2022-05-27 02:16:38.836 INFO 7 --- [ main] org.hibernate.cfg.Environment : HHH000205: Loaded properties from resource hibernate.properties: {hibernate.bytecode.use_reflection_optimizer=false, hibernate.types.print.banner=false}
2022-05-27 02:16:38.989 INFO 7 --- [ main] o.hibernate.annotations.common.Version : HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
2022-05-27 02:16:39.419 INFO 7 --- [ main] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2022-05-27 02:16:40.470 ERROR 7 --- [ main] com.zaxxer.hikari.pool.HikariPool : HikariPool-1 - Exception during pool initialization.
org.postgresql.util.PSQLException: Connection to compreface-postgres-db:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:303)
at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:51)
at org.postgresql.jdbc.PgConnection.<init>(PgConnection.java:225)
at org.postgresql.Driver.makeConnection(Driver.java:465)
at org.postgresql.Driver.connect(Driver.java:264)
at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:138)
at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:358)
at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:206)
at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:477)
at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:560)
at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115)
at com.zaxxer.hikari.HikariDataSource.getConnection(HikariDataSource.java:112)
at org.hibernate.engine.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:122)API
at org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess.obtainConnection(JdbcEnvironmentInitiator.java:180)
at org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator.initiateService(JdbcEnvironmentInitiator.java:68)
at org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator.initiateService(JdbcEnvironmentInitiator.java:35)
at org.hibernate.boot.registry.internal.StandardServiceRegistryImpl.initiateService(StandardServiceRegistryImpl.java:101)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.createService(AbstractServiceRegistryImpl.java:263)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.initializeService(AbstractServiceRegistryImpl.java:237)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.getService(AbstractServiceRegistryImpl.java:214)
at org.hibernate.id.factory.internal.DefaultIdentifierGeneratorFactory.injectServices(DefaultIdentifierGeneratorFactory.java:152)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.injectDependencies(AbstractServiceRegistryImpl.java:286)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.initializeService(AbstractServiceRegistryImpl.java:243)
at org.hibernate.service.internal.AbstractServiceRegistryImpl.getService(AbstractServiceRegistryImpl.java:214)
at org.hibernate.boot.internal.InFlightMetadataCollectorImpl.<init>(InFlightMetadataCollectorImpl.java:176)
at org.hibernate.boot.model.process.spi.MetadataBuildingProcess.complete(MetadataBuildingProcess.java:118)
at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.metadata(EntityManagerFactoryBuilderImpl.java:1224)
at org.hibernate.jpa.boot.internal.EntityManagerFactoryBuilderImpl.build(EntityManagerFactoryBuilderImpl.java:1255)
at org.springframework.orm.jpa.vendor.SpringHibernateJpaPersistenceProvider.createContainerEntityManagerFactory(SpringHibernateJpaPersistenceProvider.java:58)
at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.createNativeEntityManagerFactory(LocalContainerEntityManagerFactoryBean.java:365)
at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.buildNativeEntityManagerFactory(AbstractEntityManagerFactoryBean.java:391)
at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.afterPropertiesSet(AbstractEntityManagerFactoryBean.java:378)
at org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean.afterPropertiesSet(LocalContainerEntityManagerFactoryBean.java:341)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1853)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1790)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:594)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:324)
at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:234)
at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:322)
at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveReference(BeanDefinitionValueResolver.java:330)
at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveValueIfNecessary(BeanDefinitionValueResolver.java:113)
at org.springframework.beans.factory.support.ConstructorResolver.resolveConstructorArguments(ConstructorResolver.java:690)
at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:507)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1336)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1176)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:556)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveInnerBean(BeanDefinitionValueResolver.java:374)
at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveValueIfNecessary(BeanDefinitionValueResolver.java:134)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyPropertyValues(AbstractAutowireCapableBeanFactory.java:1697)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.populateBean(AbstractAutowireCapableBeanFactory.java:1442)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:593)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:324)
at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:234)
at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:322)
at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
at org.springframework.beans.factory.config.DependencyDescriptor.resolveCandidate(DependencyDescriptor.java:276)
at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1307)
at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1227)
at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:884)
at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:788)
at org.springframework.beans.factory.support.ConstructorResolver.autowireConstructor(ConstructorResolver.java:227)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.autowireConstructor(AbstractAutowireCapableBeanFactory.java:1356)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1203)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:556)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:324)
at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:234)
at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:322)
at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:202)
at org.springframework.beans.factory.config.DependencyDescriptor.resolveCandidate(DependencyDescriptor.java:276)
at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1307)
at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1227)
at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:884)
at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:788)
at org.springframework.beans.factory.support.ConstructorResolver.autowireConstructor(ConstructorResolver.java:227)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.autowireConstructor(AbstractAutowireCapableBeanFactory.java:1356)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1203)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:556)
at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:516)
at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:324)
at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:234)
at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:322)
at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:207)
at org.springframework.boot.web.servlet.ServletContextInitializerBeans.getOrderedBeansOfType(ServletContextInitializerBeans.java:211)
at org.springframework.boot.web.servlet.ServletContextInitializerBeans.addAsRegistrationBean(ServletContextInitializerBeans.java:174)
at org.springframework.boot.web.servlet.ServletContextInitializerBeans.addAsRegistrationBean(ServletContextInitializerBeans.java:169)
at org.springframework.boot.web.servlet.ServletContextInitializerBeans.addAdaptableBeans(ServletContextInitializerBeans.java:154)
at org.springframework.boot.web.servlet.ServletContextInitializerBeans.<init>(ServletContextInitializerBeans.java:86)
at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.getServletContextInitializerBeans(ServletWebServerApplicationContext.java:255)
at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.selfInitialize(ServletWebServerApplicationContext.java:229)
at org.springframework.boot.web.embedded.tomcat.TomcatStarter.onStartup(TomcatStarter.java:53)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5128)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1384)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1374)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at org.apache.tomcat.util.threads.InlineExecutorService.execute(InlineExecutorService.java:75)
at java.base/java.util.concurrent.AbstractExecutorService.submit(Unknown Source)
at org.apache.catalina.core.ContainerBase.startInternal(ContainerBase.java:909)
at org.apache.catalina.core.StandardHost.startInternal(StandardHost.java:843)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1384)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1374)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at org.apache.tomcat.util.threads.InlineExecutorService.execute(InlineExecutorService.java:75)
at java.base/java.util.concurrent.AbstractExecutorService.submit(Unknown Source)
at org.apache.catalina.core.ContainerBase.startInternal(ContainerBase.java:909)
at org.apache.catalina.core.StandardEngine.startInternal(StandardEngine.java:262)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
at org.apache.catalina.core.StandardService.startInternal(StandardService.java:421)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
at org.apache.catalina.core.StandardServer.startInternal(StandardServer.java:930)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
at org.apache.catalina.startup.Tomcat.start(Tomcat.java:486)
at org.springframework.boot.web.embedded.tomcat.TomcatWebServer.initialize(TomcatWebServer.java:123)
at org.springframework.boot.web.embedded.tomcat.TomcatWebServer.<init>(TomcatWebServer.java:104)
at org.springframework.boot.web.embedded.tomcat.TomcatServletWebServerFactory.getTomcatWebServer(TomcatServletWebServerFactory.java:437)
at org.springframework.boot.web.embedded.tomcat.TomcatServletWebServerFactory.getWebServer(TomcatServletWebServerFactory.java:191)
at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.createWebServer(ServletWebServerApplicationContext.java:178)
at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.onRefresh(ServletWebServerApplicationContext.java:158)
at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:545)
at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.refresh(ServletWebServerApplicationContext.java:143)
at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:758)
at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:750)
at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:397)
at org.springframework.boot.SpringApplication.run(SpringApplication.java:315)
at org.springframework.boot.SpringApplication.run(SpringApplication.java:1237)
at org.springframework.boot.SpringApplication.run(SpringApplication.java:1226)
at com.exadel.frs.TrainServiceApplication.main(TrainServiceApplication.java:29)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:49)
at org.springframework.boot.loader.Launcher.launch(Launcher.java:107)
at org.springframework.boot.loader.Launcher.launch(Launcher.java:58)
at org.springframework.boot.loader.JarLauncher.main(JarLauncher.java:88)
Caused by: java.net.ConnectException: Connection refused (Connection refused)
at java.base/java.net.PlainSocketImpl.socketConnect(Native Method)
at java.base/java.net.AbstractPlainSocketImpl.doConnect(Unknown Source)
at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(Unknown Source)
at java.base/java.net.AbstractPlainSocketImpl.connect(Unknown Source)
at java.base/java.net.SocksSocketImpl.connect(Unknown Source)
at java.base/java.net.Socket.connect(Unknown Source)
at org.postgresql.core.PGStream.createSocket(PGStream.java:231)
at org.postgresql.core.PGStream.<init>(PGStream.java:95)
at org.postgresql.core.v3.ConnectionFactoryImpl.tryConnect(ConnectionFactoryImpl.java:98)
at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:213)
... 140 common frames omitted
2022-05-27 02:16:40.471 WARN 7 --- [ main] o.h.e.j.e.i.JdbcEnvironmentInitiator : HHH000342: Could not obtain connection to query metadata : Connection to compreface-postgres-db:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
2022-05-27 02:16:40.496 INFO 7 --- [ main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL10Dialect
2022-05-27 02:16:41.575 INFO 7 --- [ main] o.h.e.t.j.p.i.JtaPlatformInitiator : HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-05-27 02:16:41.583 INFO 7 --- [ main] j.LocalContainerEntityManagerFactoryBean : Initialized JPA EntityManagerFactory for persistence unit 'default'
2022-05-27 02:16:44.150 INFO 7 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 2 endpoint(s) beneath base path '/actuator'
2022-05-27 02:16:44.270 INFO 7 --- [ main] pertySourcedRequestMappingHandlerMapping : Mapped URL path [/v2/api-docs] onto method [springfox.documentation.swagger2.web.Swagger2Controller#getDocumentation(String, HttpServletRequest)]
2022-05-27 02:16:44.344 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Using default implementation for ThreadExecutor
2022-05-27 02:16:44.356 INFO 7 --- [ main] org.quartz.core.SchedulerSignalerImpl : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2022-05-27 02:16:44.356 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Quartz Scheduler v.2.3.2 created.
2022-05-27 02:16:44.357 INFO 7 --- [ main] org.quartz.simpl.RAMJobStore : RAMJobStore initialized.
2022-05-27 02:16:44.357 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Scheduler meta-data: Quartz Scheduler (v2.3.2) 'quartzScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
2022-05-27 02:16:44.357 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler 'quartzScheduler' initialized from an externally provided properties instance.
2022-05-27 02:16:44.357 INFO 7 --- [ main] org.quartz.impl.StdSchedulerFactory : Quartz scheduler version: 2.3.2
2022-05-27 02:16:44.357 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : JobFactory set to: org.springframework.scheduling.quartz.SpringBeanJobFactory@63d0e8d
2022-05-27 02:16:44.361 INFO 7 --- [ main] org.quartz.core.QuartzScheduler : Scheduler quartzScheduler_$_NON_CLUSTERED started.
2022-05-27 02:16:44.381 WARN 7 --- [ main] c.n.c.sources.URLConfigurationSource : No URLs will be polled as dynamic configuration sources.
2022-05-27 02:16:44.381 INFO 7 --- [ main] c.n.c.sources.URLConfigurationSource : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2022-05-27 02:16:44.387 WARN 7 --- [ main] c.n.c.sources.URLConfigurationSource : No URLs will be polled as dynamic configuration sources.
2022-05-27 02:16:44.387 INFO 7 --- [ main] c.n.c.sources.URLConfigurationSource : To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath.
2022-05-27 02:16:44.492 INFO 7 --- [ main] o.s.s.concurrent.ThreadPoolTaskExecutor : Initializing ExecutorService 'applicationTaskExecutor'
2022-05-27 02:16:44.935 INFO 7 --- [ main] o.a.coyote.http11.Http11NioProtocol : Starting ProtocolHandler ["http-nio-8080"]
2022-05-27 02:16:44.952 INFO 7 --- [ main] o.s.b.w.embedded.tomcat.TomcatWebServer : Tomcat started on port(s): 8080 (http) with context path ''
2022-05-27 02:16:44.955 INFO 7 --- [ main] d.s.w.p.DocumentationPluginsBootstrapper : Context refreshed
2022-05-27 02:16:44.986 INFO 7 --- [ main] d.s.w.p.DocumentationPluginsBootstrapper : Found 2 custom documentation plugin(s)
2022-05-27 02:16:45.151 INFO 7 --- [ main] s.d.s.w.s.ApiListingReferenceScanner : Scanning for api listing references
2022-05-27 02:16:45.411 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: recognizeBase64UsingPOST_1
2022-05-27 02:16:45.414 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: downloadImgUsingGET_1
2022-05-27 02:16:45.482 INFO 7 --- [ main] s.d.s.w.s.ApiListingReferenceScanner : Scanning for api listing references
2022-05-27 02:16:45.509 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: getCheckDemoUsingGET_1
2022-05-27 02:16:45.522 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: detectUsingPOST_1
2022-05-27 02:16:45.526 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: detectBase64UsingPOST_1
2022-05-27 02:16:45.531 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: addEmbeddingUsingPOST_1
2022-05-27 02:16:45.534 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: addEmbeddingBase64UsingPOST_1
2022-05-27 02:16:45.535 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: deleteEmbeddingByIdUsingDELETE_1
2022-05-27 02:16:45.538 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: deleteEmbeddingsByIdUsingPOST_1
2022-05-27 02:16:45.540 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: downloadImgUsingGET_2
2022-05-27 02:16:45.544 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: listEmbeddingsUsingGET_1
2022-05-27 02:16:45.552 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: recognizeBase64UsingPOST_2
2022-05-27 02:16:45.554 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: recognizeFileUsingPOST_1
2022-05-27 02:16:45.556 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: removeAllSubjectEmbeddingsUsingDELETE_1
2022-05-27 02:16:45.557 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: migrateUsingPOST_1
2022-05-27 02:16:45.560 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: handleUsingGET_1
2022-05-27 02:16:45.561 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: handleUsingGET_2
2022-05-27 02:16:45.568 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: recognizeUsingPOST_1
2022-05-27 02:16:45.570 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: recognizeBase64UsingPOST_3
2022-05-27 02:16:45.571 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: downloadImgUsingGET_3
2022-05-27 02:16:45.574 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: createSubjectUsingPOST_1
2022-05-27 02:16:45.575 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: deleteSubjectUsingDELETE_1
2022-05-27 02:16:45.577 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: deleteSubjectsUsingDELETE_1
2022-05-27 02:16:45.577 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: listSubjectsUsingGET_1
2022-05-27 02:16:45.578 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: renameSubjectUsingPUT_1
2022-05-27 02:16:45.587 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: verifyUsingPOST_1
2022-05-27 02:16:45.590 INFO 7 --- [ main] .d.s.w.r.o.CachingOperationNameGenerator : Generating unique operation named: verifyBase64UsingPOST_1
2022-05-27 02:16:45.611 INFO 7 --- [ main] com.exadel.frs.TrainServiceApplication : Started TrainServiceApplication in 10.935 seconds (JVM running for 11.554)
2022-05-27 02:17:36.043 INFO 7 --- [nio-8080-exec-1] o.a.c.c.C.[Tomcat].[localhost].[/] : Initializing Spring DispatcherServlet 'dispatcherServlet'
2022-05-27 02:17:36.043 INFO 7 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Initializing Servlet 'dispatcherServlet'
2022-05-27 02:17:36.056 INFO 7 --- [nio-8080-exec-1] o.s.web.servlet.DispatcherServlet : Completed initialization in 13 ms
2022-05-27 02:17:37.353 INFO 7 --- [nio-8080-exec-1] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Starting...
2022-05-27 02:17:37.418 INFO 7 --- [nio-8080-exec-1] com.zaxxer.hikari.HikariDataSource : HikariPool-1 - Start completed.
2022-05-27 02:18:35.650 INFO 7 --- [nio-8080-exec-6] org.nd4j.linalg.factory.Nd4jBackend : Loaded [CpuBackend] backend
2022-05-27 02:18:37.166 INFO 7 --- [nio-8080-exec-6] org.nd4j.nativeblas.NativeOpsHolder : Number of threads used for linear algebra: 6
2022-05-27 02:18:37.167 WARN 7 --- [nio-8080-exec-6] o.n.l.cpu.nativecpu.CpuNDArrayFactory : *********************************** CPU Feature Check Warning ***********************************
2022-05-27 02:18:37.167 WARN 7 --- [nio-8080-exec-6] o.n.l.cpu.nativecpu.CpuNDArrayFactory : Warning: Initializing ND4J with Generic x86 binary on a CPU with AVX/AVX2 support
2022-05-27 02:18:37.167 WARN 7 --- [nio-8080-exec-6] o.n.l.cpu.nativecpu.CpuNDArrayFactory : Using ND4J with AVX/AVX2 will improve performance. See deeplearning4j.org/cpu for more details
2022-05-27 02:18:37.167 WARN 7 --- [nio-8080-exec-6] o.n.l.cpu.nativecpu.CpuNDArrayFactory : Or set environment variable ND4J_IGNORE_AVX=true to suppress this warning
2022-05-27 02:18:37.167 WARN 7 --- [nio-8080-exec-6] o.n.l.cpu.nativecpu.CpuNDArrayFactory : *************************************************************************************************
2022-05-27 02:18:37.174 INFO 7 --- [nio-8080-exec-6] org.nd4j.nativeblas.Nd4jBlas : Number of threads used for OpenMP BLAS: 6
2022-05-27 02:18:37.196 INFO 7 --- [nio-8080-exec-6] o.n.l.a.o.e.DefaultOpExecutioner : Backend used: [CPU]; OS: [Linux]
2022-05-27 02:18:37.196 INFO 7 --- [nio-8080-exec-6] o.n.l.a.o.e.DefaultOpExecutioner : Cores: [12]; Memory: [8.0GB];
2022-05-27 02:18:37.196 INFO 7 --- [nio-8080-exec-6] o.n.l.a.o.e.DefaultOpExecutioner : Blas vendor: [OPENBLAS]
2022-05-27 02:20:41.084 INFO 7 --- [PG-JDBC I/O (2)] c.e.f.c.t.s.NotificationReceiverService : /channels3/ channel name: face_collection_update_msg payload {
"cacheAction" : "UPDATE",
"apiKey" : "00000000-0000-0000-0000-000000000002",
"uuid" : "22874138-cb7b-476a-a804-7241243a1b5b"
}
2022-05-27 02:20:41.113 ERROR 7 --- [nio-8080-exec-8] c.e.f.c.h.ResponseExceptionHandler : Undefined exception occurred
java.lang.IllegalStateException: Cannot perform operation "subi" - shapes are not equal and are not broadcastable.first.shape=[20, 512], second.shape=[128]
at org.nd4j.common.base.Preconditions.throwStateEx(Preconditions.java:641)
at org.nd4j.common.base.Preconditions.checkState(Preconditions.java:376)
at org.nd4j.linalg.api.shape.Shape.assertBroadcastable(Shape.java:265)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3238)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3225)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.euclidean_distance(EuclideanDistanceClassifier.java:146)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.recognize(EuclideanDistanceClassifier.java:130)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.predict(EuclideanDistanceClassifier.java:58)
at com.exadel.frs.core.trainservice.component.FaceClassifierPredictor.predict(FaceClassifierPredictor.java:34)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processFaceResult(FaceRecognizeProcessServiceImpl.java:72)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:62)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:26)
at com.exadel.frs.core.trainservice.controller.RecognizeController.recognize(RecognizeController.java:75)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$FastClassBySpringCGLIB$$52b4c4f5.invoke(<generated>)
at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:771)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.validation.beanvalidation.MethodValidationInterceptor.invoke(MethodValidationInterceptor.java:119)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:691)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$EnhancerBySpringCGLIB$$5c9347ab.recognize(<generated>)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:652)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at com.exadel.frs.core.trainservice.filter.SecurityValidationFilter.doFilter(SecurityValidationFilter.java:124)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:374)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.base/java.lang.Thread.run(Unknown Source)
2022-05-27 02:20:49.601 ERROR 7 --- [nio-8080-exec-9] c.e.f.c.h.ResponseExceptionHandler : Undefined exception occurred
java.lang.IllegalStateException: Cannot perform operation "subi" - shapes are not equal and are not broadcastable.first.shape=[20, 512], second.shape=[128]
at org.nd4j.common.base.Preconditions.throwStateEx(Preconditions.java:641)
at org.nd4j.common.base.Preconditions.checkState(Preconditions.java:376)
at org.nd4j.linalg.api.shape.Shape.assertBroadcastable(Shape.java:265)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3238)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3225)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.euclidean_distance(EuclideanDistanceClassifier.java:146)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.recognize(EuclideanDistanceClassifier.java:130)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.predict(EuclideanDistanceClassifier.java:58)
at com.exadel.frs.core.trainservice.component.FaceClassifierPredictor.predict(FaceClassifierPredictor.java:34)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processFaceResult(FaceRecognizeProcessServiceImpl.java:72)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:62)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:26)
at com.exadel.frs.core.trainservice.controller.RecognizeController.recognize(RecognizeController.java:75)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$FastClassBySpringCGLIB$$52b4c4f5.invoke(<generated>)
at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:771)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.validation.beanvalidation.MethodValidationInterceptor.invoke(MethodValidationInterceptor.java:119)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:691)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$EnhancerBySpringCGLIB$$5c9347ab.recognize(<generated>)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:652)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at com.exadel.frs.core.trainservice.filter.SecurityValidationFilter.doFilter(SecurityValidationFilter.java:124)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:374)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.base/java.lang.Thread.run(Unknown Source)
2022-05-27 02:22:05.859 ERROR 7 --- [nio-8080-exec-5] c.e.f.c.h.ResponseExceptionHandler : Undefined exception occurred
java.lang.IllegalStateException: Cannot perform operation "subi" - shapes are not equal and are not broadcastable.first.shape=[20, 512], second.shape=[128]
at org.nd4j.common.base.Preconditions.throwStateEx(Preconditions.java:641)
at org.nd4j.common.base.Preconditions.checkState(Preconditions.java:376)
at org.nd4j.linalg.api.shape.Shape.assertBroadcastable(Shape.java:265)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3238)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3225)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.euclidean_distance(EuclideanDistanceClassifier.java:146)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.recognize(EuclideanDistanceClassifier.java:130)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.predict(EuclideanDistanceClassifier.java:58)
at com.exadel.frs.core.trainservice.component.FaceClassifierPredictor.predict(FaceClassifierPredictor.java:34)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processFaceResult(FaceRecognizeProcessServiceImpl.java:72)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:62)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:26)
at com.exadel.frs.core.trainservice.controller.RecognizeController.recognize(RecognizeController.java:75)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$FastClassBySpringCGLIB$$52b4c4f5.invoke(<generated>)
at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:771)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.validation.beanvalidation.MethodValidationInterceptor.invoke(MethodValidationInterceptor.java:119)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:691)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$EnhancerBySpringCGLIB$$5c9347ab.recognize(<generated>)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:652)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at com.exadel.frs.core.trainservice.filter.SecurityValidationFilter.doFilter(SecurityValidationFilter.java:124)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:374)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.base/java.lang.Thread.run(Unknown Source)
2022-05-27 02:22:53.185 ERROR 7 --- [nio-8080-exec-6] c.e.f.c.h.ResponseExceptionHandler : Undefined exception occurred
java.lang.IllegalStateException: Cannot perform operation "subi" - shapes are not equal and are not broadcastable.first.shape=[20, 512], second.shape=[128]
at org.nd4j.common.base.Preconditions.throwStateEx(Preconditions.java:641)
at org.nd4j.common.base.Preconditions.checkState(Preconditions.java:376)
at org.nd4j.linalg.api.shape.Shape.assertBroadcastable(Shape.java:265)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3238)
at org.nd4j.linalg.api.ndarray.BaseNDArray.subi(BaseNDArray.java:3225)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.euclidean_distance(EuclideanDistanceClassifier.java:146)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.recognize(EuclideanDistanceClassifier.java:130)
at com.exadel.frs.core.trainservice.component.classifiers.EuclideanDistanceClassifier.predict(EuclideanDistanceClassifier.java:58)
at com.exadel.frs.core.trainservice.component.FaceClassifierPredictor.predict(FaceClassifierPredictor.java:34)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processFaceResult(FaceRecognizeProcessServiceImpl.java:72)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:62)
at com.exadel.frs.core.trainservice.service.FaceRecognizeProcessServiceImpl.processImage(FaceRecognizeProcessServiceImpl.java:26)
at com.exadel.frs.core.trainservice.controller.RecognizeController.recognize(RecognizeController.java:75)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$FastClassBySpringCGLIB$$52b4c4f5.invoke(<generated>)
at org.springframework.cglib.proxy.MethodProxy.invoke(MethodProxy.java:218)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.invokeJoinpoint(CglibAopProxy.java:771)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.validation.beanvalidation.MethodValidationInterceptor.invoke(MethodValidationInterceptor.java:119)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186)
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:749)
at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:691)
at com.exadel.frs.core.trainservice.controller.RecognizeController$$EnhancerBySpringCGLIB$$5c9347ab.recognize(<generated>)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.base/java.lang.reflect.Method.invoke(Unknown Source)
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:652)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at com.exadel.frs.core.trainservice.filter.SecurityValidationFilter.doFilter(SecurityValidationFilter.java:124)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:93)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:374)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.base/java.lang.Thread.run(Unknown Source)
Core
[uWSGI] getting INI configuration from uwsgi.ini
*** Starting uWSGI 2.0.19 (64bit) on [Fri May 27 02:16:36 2022] ***
compiled with version: 9.4.0 on 05 May 2022 14:03:34
os: Linux-5.13.0-41-generic #46~20.04.1-Ubuntu SMP Wed Apr 20 13:16:21 UTC 2022
nodename: 1cec48fd7cc5
machine: x86_64
clock source: unix
detected number of CPU cores: 12
current working directory: /app/ml
detected binary path: /usr/local/bin/uwsgi
!!! no internal routing support, rebuild with pcre support !!!
setgid() to 33
setuid() to 33
your memory page size is 4096 bytes
detected max file descriptor number: 1048576
lock engine: pthread robust mutexes
thunder lock: disabled (you can enable it with --thunder-lock)
uwsgi socket 0 bound to TCP address 0.0.0.0:3000 fd 3
Python version: 3.8.10 (default, Mar 15 2022, 12:22:08) [GCC 9.4.0]
Python main interpreter initialized at 0x55e6ba782650
python threads support enabled
your server socket listen backlog is limited to 100 connections
your mercy for graceful operations on workers is 60 seconds
mapped 145808 bytes (142 KB) for 1 cores
*** Operational MODE: single process ***
{"severity": "INFO", "message": "{'BUILD_VERSION': 'dev', 'CALCULATION_PLUGIN': 'insightface.Calculator@arcface_mobilefacenet', 'EXTRA_PLUGINS': ['insightface.Landmarks2d106Detector', 'insightface.GenderDetector', 'insightface.AgeDetector', 'insightface.facemask.MaskDetector'], 'FACE_DETECTION_PLUGIN': 'insightface.FaceDetector@retinaface_mnet025_v1', 'GPU_IDX': 0, 'IMG_LENGTH_LIMIT': 640, 'INTEL_OPTIMIZATION': False, 'IS_DEV_ENV': False, 'LOGGING_LEVEL_NAME': 'DEBUG', 'ML_PORT': 3000}", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Creating new app for WSGI", "request": null, "logger": "src.app", "module": "app", "traceback": null, "build_version": "dev"}
WSGI app 0 (mountpoint='') ready in 1 seconds on interpreter 0x55e6ba782650 pid: 1 (default app)
*** uWSGI is running in multiple interpreter mode ***
spawned uWSGI master process (pid: 1)
spawned uWSGI worker 1 (pid: 30, cores: 1)
{"severity": "INFO", "message": "200 OK", "request": {"method": "GET", "path": "/status", "filename": "", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
[02:18:30] ../src/nnvm/legacy_json_util.cc:208: Loading symbol saved by previous version v1.2.0. Attempting to upgrade...
[02:18:30] ../src/nnvm/legacy_json_util.cc:216: Symbol successfully upgraded!
[02:18:30] ../src/engine/engine.cc:54: MXNet start using engine: ThreadedEnginePerDevice
[02:18:30] ../src/base.cc:79: cuDNN lib mismatch: linked-against version 8101 != compiled-against version 8100. Set MXNET_CUDNN_LIB_CHECKING=0 to quiet this warning.
[32, 16, 8] {'32': {'SCALES': (32, 16), 'BASE_SIZE': 16, 'RATIOS': (1.0,), 'ALLOWED_BORDER': 9999}, '16': {'SCALES': (8, 4), 'BASE_SIZE': 16, 'RATIOS': (1.0,), 'ALLOWED_BORDER': 9999}, '8': {'SCALES': (2, 1), 'BASE_SIZE': 16, 'RATIOS': (1.0,), 'ALLOWED_BORDER': 9999}}
use_landmarks True
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=204, y_min=35, x_max=399, y_max=291, probability=0.999189555644989, _np_landmarks=array([[257.75354, 139.2549 ],\n [349.7589 , 131.92838],\n [310.82855, 188.68945],\n [276.87128, 233.90598],\n [349.61676, 227.42078]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "3_Beautiful-girl-with-a-gentle-smile.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
[02:18:35] ../src/nnvm/legacy_json_util.cc:208: Loading symbol saved by previous version v1.0.0. Attempting to upgrade...
[02:18:35] ../src/nnvm/legacy_json_util.cc:216: Symbol successfully upgraded!
[02:18:35] ../src/nnvm/legacy_json_util.cc:208: Loading symbol saved by previous version v1.3.0. Attempting to upgrade...
[02:18:35] ../src/nnvm/legacy_json_util.cc:216: Symbol successfully upgraded!
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "3_Beautiful-girl-with-a-gentle-smile.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=204, y_min=35, x_max=399, y_max=291, probability=0.999189555644989, _np_landmarks=array([[257.75354, 139.2549 ],\n [349.7589 , 131.92838],\n [310.82855, 188.68945],\n [276.87128, 233.90598],\n [349.61676, 227.42078]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "3_Beautiful-girl-with-a-gentle-smile.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "3_Beautiful-girl-with-a-gentle-smile.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
{"severity": "DEBUG", "message": "Found: BoundingBoxDTO(x_min=240, y_min=112, x_max=507, y_max=476, probability=0.9996230602264404, _np_landmarks=array([[308.35318, 269.45126],\n [434.8677 , 260.56412],\n [374.52457, 341.2638 ],\n [323.1916 , 387.66245],\n [436.38828, 380.68118]], dtype=float32))", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.facescan.plugins.insightface.insightface", "module": "insightface", "traceback": null, "build_version": "dev"}
{"severity": "INFO", "message": "200 OK", "request": {"method": "POST", "path": "/find_faces", "filename": "GettyImages-1092658864_thumb-732x549.jpg", "api_key": "", "remote_addr": "172.18.0.4"}, "logger": "src.services.flask_.log_response", "module": "log_response", "traceback": null, "build_version": "dev"}
Postgres
The files belonging to this database system will be owned by user "postgres".
This user must also own the server process.
The database cluster will be initialized with locale "en_US.utf8".
The default database encoding has accordingly been set to "UTF8".
The default text search configuration will be set to "english".
Data page checksums are disabled.
fixing permissions on existing directory /var/lib/postgresql/data ... ok
creating subdirectories ... ok
selecting default max_connections ... 100
selecting default shared_buffers ... 128MB
selecting default timezone ... Etc/UTC
selecting dynamic shared memory implementation ... posix
creating configuration files ... ok
running bootstrap script ... ok
performing post-bootstrap initialization ... ok
syncing data to disk ... ok
Success. You can now start the database server using:
pg_ctl -D /var/lib/postgresql/data -l logfile start
WARNING: enabling "trust" authentication for local connections
You can change this by editing pg_hba.conf or using the option -A, or
--auth-local and --auth-host, the next time you run initdb.
waiting for server to start....2022-05-27 02:16:38.608 UTC [43] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432"
2022-05-27 02:16:38.929 UTC [44] LOG: database system was shut down at 2022-05-27 02:16:32 UTC
2022-05-27 02:16:38.991 UTC [43] LOG: database system is ready to accept connections
done
server started
CREATE DATABASE
/usr/local/bin/docker-entrypoint.sh: ignoring /docker-entrypoint-initdb.d/*
2022-05-27 02:16:40.015 UTC [43] LOG: received fast shutdown request
waiting for server to shut down....2022-05-27 02:16:40.062 UTC [43] LOG: aborting any active transactions
2022-05-27 02:16:40.063 UTC [43] LOG: background worker "logical replication launcher" (PID 50) exited with exit code 1
2022-05-27 02:16:40.063 UTC [45] LOG: shutting down
2022-05-27 02:16:40.299 UTC [43] LOG: database system is shut down
done
server stopped
PostgreSQL init process complete; ready for start up.
2022-05-27 02:16:40.353 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432
2022-05-27 02:16:40.353 UTC [1] LOG: listening on IPv6 address "::", port 5432
2022-05-27 02:16:40.420 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432"
2022-05-27 02:16:40.554 UTC [61] LOG: database system was shut down at 2022-05-27 02:16:40 UTC
2022-05-27 02:16:40.590 UTC [1] LOG: database system is ready to accept connections
2022-05-27 02:16:47.417 UTC [70] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
2022-05-27 02:16:47.664 UTC [72] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
2022-05-27 02:16:47.669 UTC [74] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
2022-05-27 02:16:48.651 UTC [71] ERROR: relation "public.databasechangeloglock" does not exist at character 22
2022-05-27 02:16:48.651 UTC [71] STATEMENT: SELECT COUNT(*) FROM public.databasechangeloglock
2022-05-27 02:17:04.778 UTC [71] WARNING: there is no transaction in progress
2022-05-27 02:17:37.357 UTC [76] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
2022-05-27 02:17:37.519 UTC [78] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
2022-05-27 02:17:37.525 UTC [80] FATAL: unsupported frontend protocol 1234.5680: server supports 2.0 to 3.0
It looks like a neural network works, thanks. The problem with the Recognition service - it looks like you run it on an existing collection, that wasn't on mobilenet. This is a problem because of different embedding lengths. Not sure why the Verification service hangs and why detection doesn't show results. But we will figure that out before release
You are most welcome. Any ETA for the new release supporting RTX3XXX?
In an optimistic scenario, we will release it as an addition to 1.0 version, so it could be this month
Any progress on this? :)
Yes! We released a new version: https://github.com/exadel-inc/CompreFace/releases/tag/v1.0.1 Please try it out
Yes! We released a new version: https://github.com/exadel-inc/CompreFace/releases/tag/v1.0.1 Please try it out
Installed everything but in logs i'm getting:
compreface-core | DAMN ! worker 1 (pid: 156) died, killed by signal 9 :( trying respawn ... compreface-core | Respawned uWSGI worker 1 (new pid: 177)
Any ideas?
Could you share a full log? What GPU do you use?
I use nginx to reverse proxy localhost:80, and it only show 403 for /
and /login
.
I use nginx to reverse proxy localhost:80, and it only show 403 for
/
and/login
.Details
I found my problem, I have my nginx mis-configured and the test command curl -v localhost:8000
is not correct.
But I still got Api nodeloading ...
. My server support avx
feature, but didn't have a gpu card. Does it matters?
CompreFace could be run on most modern computers with x86 processor and AVX support. To check AVX support on Linux run lscpu | grep avx command
From the doc https://barionleg.github.io/CompreFace/#getting-started-with-compreface
Describe the bug I try to run service with GPU support, specifically Mobilenet-gpu build. I start it by
docker-compose up
, than go to web gui and use verification service. Gui stuck for a minute and error occure:<html> <head><title>504 Gateway Time-out</title></head> <body> <center><h1>504 Gateway Time-out</h1></center> <hr><center>nginx</center> </body> </html> <!-- a padding to disable MSIE and Chrome friendly error page --> <!-- a padding to disable MSIE and Chrome friendly error page --> <!-- a padding to disable MSIE and Chrome friendly error page --> <!-- a padding to disable MSIE and Chrome friendly error page --> <!-- a padding to disable MSIE and Chrome friendly error page --> <!-- a padding to disable MSIE and Chrome friendly error page -->
Used GPU: dual-rtx3060ti-08g-v2Than I change GPU to rtx-2080-super-gaming-x-trio, and everything work well on the same docker images.
To Reproduce Steps to reproduce the behavior:
Expected behavior Compreface work with dual-rtx3060ti-08g-v2
Desktop (please complete the following information):