absmach / supermq

Event-driven Infrastructure for Modern Cloud
https://www.abstractmachines.fr/magistrala.html
Apache License 2.0
2.48k stars 676 forks source link

error: failed to create entity : 502 Bad Gateway #1447

Closed iot-lorawan closed 3 years ago

iot-lorawan commented 3 years ago

Hi, I install and run mainflux and mainflux ui, it work ok, when i create user for login into ui web, it raise erro with error: failed to create entity : 502 Bad Gateway Could you help.

图片

图片

图片

图片

Best Regards,

iot-lorawan commented 3 years ago

Hi, I reinstall mainflux and mainflux ui with make clean and then make run. then priovison with run "mainflux-cli provision test" 图片

but it still fail in login in web ui  with username: romantic_golick@email.com and password:12345678

图片

mteodor commented 3 years ago

so your problem with database is resolved? what does the users service log says when you try to log in?

iot-lorawan commented 3 years ago

Hi mteodor, when login in web ui, the ui log is : 图片

图片

Thanks,

iot-lorawan commented 3 years ago

图片

mteodor commented 3 years ago

If you are experimenting and your data in users db is not important you can remove database volumes and your volumes would be recreated properly. If you need your data you will have to find a way to upgrade database file, since your database volume is created with some prior version of postgres.

iot-lorawan commented 3 years ago

Hi meteodor, I remove all docker volume, and rerun ,but it seems not work,

the mainflux log: ubuntu@ubuntu:~/mainflux$ docker volume ls DRIVER VOLUME NAME ubuntu@ubuntu:~/mainflux$ make run docker-compose -f docker/docker-compose.yml up Creating network "docker_mainflux-base-net" with driver "bridge" Creating volume "docker_mainflux-auth-db-volume" with default driver Creating volume "docker_mainflux-users-db-volume" with default driver Creating volume "docker_mainflux-things-db-volume" with default driver Creating volume "docker_mainflux-auth-redis-volume" with default driver Creating volume "docker_mainflux-es-redis-volume" with default driver Creating volume "docker_mainflux-mqtt-broker-volume" with default driver Creating mainflux-auth-db ... done Creating mainflux-vernemq ... done Creating mainflux-jaeger ... done Creating mainflux-auth-redis ... done Creating mainflux-nats ... done Creating mainflux-users-db ... done Creating mainflux-es-redis ... done Creating mainflux-things-db ... done Creating mainflux-auth ... done Creating mainflux-things ... done Creating mainflux-users ... done Creating mainflux-coap ... done Creating mainflux-mqtt ... done Creating mainflux-http ... done Creating mainflux-nginx ... done Attaching to mainflux-auth-redis, mainflux-nats, mainflux-things-db, mainflux-auth-db, mainflux-users-db, mainflux-es-redis, mainflux-jaeger, mainflux-vernemq, mainflux-auth, mainflux-things, mainflux-users, mainflux-http, mainflux-coap, mainflux-mqtt, mainflux-nginx mainflux-auth | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.2:5432: connect: connection refused","ts":"2021-08-16T00:51:27.788502337Z"} mainflux-auth-db | The files belonging to this database system will be owned by user "postgres". mainflux-auth-db | This user must also own the server process. mainflux-auth-db | mainflux-auth-db | The database cluster will be initialized with locale "en_US.utf8". mainflux-auth-db | The default database encoding has accordingly been set to "UTF8". mainflux-auth-db | The default text search configuration will be set to "english". mainflux-auth-db | mainflux-auth-db | Data page checksums are disabled. mainflux-auth-db | mainflux-auth-db | fixing permissions on existing directory /var/lib/postgresql/data ... ok mainflux-auth-db | creating subdirectories ... ok mainflux-auth-db | selecting dynamic shared memory implementation ... posix mainflux-auth-db | selecting default max_connections ... 100 mainflux-auth-db | selecting default shared_buffers ... 128MB mainflux-auth-db | selecting default time zone ... UTC mainflux-auth-db | creating configuration files ... ok mainflux-auth-db | running bootstrap script ... ok mainflux-auth-db | performing post-bootstrap initialization ... sh: locale: not found mainflux-auth-db | 2021-08-16 00:51:28.819 UTC [30] WARNING: no usable system locales were found mainflux-auth-db | ok mainflux-auth-db | syncing data to disk ... ok mainflux-auth-db | mainflux-auth-db | mainflux-auth-db | Success. You can now start the database server using: mainflux-auth-db | mainflux-auth-db | pg_ctl -D /var/lib/postgresql/data -l logfile start mainflux-auth-db | mainflux-auth-db | initdb: warning: enabling "trust" authentication for local connections mainflux-auth-db | You can change this by editing pg_hba.conf or using the option -A, or mainflux-auth-db | --auth-local and --auth-host, the next time you run initdb. mainflux-auth-db | waiting for server to start....2021-08-16 00:51:32.657 UTC [35] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-auth-db | 2021-08-16 00:51:32.658 UTC [35] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-auth-db | 2021-08-16 00:51:32.681 UTC [36] LOG: database system was shut down at 2021-08-16 00:51:32 UTC mainflux-auth-db | 2021-08-16 00:51:32.686 UTC [35] LOG: database system is ready to accept connections mainflux-auth-db | done mainflux-auth-db | server started mainflux-auth-db | CREATE DATABASE mainflux-auth-db | mainflux-auth-db | mainflux-auth-db | /usr/local/bin/docker-entrypoint.sh: ignoring /docker-entrypoint-initdb.d/ mainflux-auth-db | mainflux-auth-db | 2021-08-16 00:51:33.021 UTC [35] LOG: received fast shutdown request mainflux-auth-db | waiting for server to shut down...2021-08-16 00:51:33.023 UTC [35] LOG: aborting any active transactions mainflux-auth-db | 2021-08-16 00:51:33.026 UTC [35] LOG: background worker "logical replication launcher" (PID 42) exited with exit code 1 mainflux-auth-db | 2021-08-16 00:51:33.026 UTC [37] LOG: shutting down mainflux-auth-db | .2021-08-16 00:51:33.035 UTC [35] LOG: database system is shut down mainflux-auth-db | done mainflux-auth-db | server stopped mainflux-auth-db | mainflux-auth-db | PostgreSQL init process complete; ready for start up. mainflux-auth-db | mainflux-auth-db | 2021-08-16 00:51:33.145 UTC [1] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-auth-db | 2021-08-16 00:51:33.155 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-auth-db | 2021-08-16 00:51:33.155 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-auth-db | 2021-08-16 00:51:33.156 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-auth-db | 2021-08-16 00:51:33.159 UTC [49] LOG: database system was shut down at 2021-08-16 00:51:33 UTC mainflux-auth-db | 2021-08-16 00:51:33.161 UTC [1] LOG: database system is ready to accept connections mainflux-auth-redis | 1:C 16 Aug 2021 00:51:26.396 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-auth-redis | 1:C 16 Aug 2021 00:51:26.396 # Redis version=6.2.2, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-auth-redis | 1:C 16 Aug 2021 00:51:26.396 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-auth-redis | 1:M 16 Aug 2021 00:51:26.396 monotonic clock: POSIX clock_gettime mainflux-auth-redis | 1:M 16 Aug 2021 00:51:26.402 Running mode=standalone, port=6379. mainflux-auth-redis | 1:M 16 Aug 2021 00:51:26.402 # Server initialized mainflux-auth-redis | 1:M 16 Aug 2021 00:51:26.402 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-auth-redis | 1:M 16 Aug 2021 00:51:26.403 Ready to accept connections mainflux-coap | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:32.042115237Z"} mainflux-coap | {"level":"info","message":"CoAP adapter service started, exposed port 5683","ts":"2021-08-16T00:51:32.061480329Z"} mainflux-coap | {"level":"info","message":"CoAP service started, exposed port 5683","ts":"2021-08-16T00:51:32.061238137Z"} mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # Redis version=6.2.2, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 monotonic clock: POSIX clock_gettime mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 Running mode=standalone, port=6379. mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 # Server initialized mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.815 * Ready to accept connections mainflux-http | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:31.922584979Z"} mainflux-http | {"level":"info","message":"HTTP adapter service started on port 8185","ts":"2021-08-16T00:51:31.969811667Z"} mainflux-jaeger | 2021/08/16 00:51:27 maxprocs: Leaving GOMAXPROCS=2: CPU quota undefined mainflux-jaeger | {"level":"info","ts":1629075087.1965857,"caller":"flags/service.go:116","msg":"Mounting metrics handler on admin server","route":"/metrics"} mainflux-jaeger | {"level":"info","ts":1629075087.1983154,"caller":"flags/admin.go:120","msg":"Mounting health check on admin server","route":"/"} mainflux-jaeger | {"level":"info","ts":1629075087.1992738,"caller":"flags/admin.go:126","msg":"Starting admin HTTP server","http-addr":":14269"} mainflux-jaeger | {"level":"info","ts":1629075087.1992972,"caller":"flags/admin.go:112","msg":"Admin server started","http.host-port":"[::]:14269","health-status":"unavailable"} mainflux-jaeger | {"level":"info","ts":1629075087.206957,"caller":"memory/factory.go:61","msg":"Memory storage initialized","configuration":{"MaxTraces":0}} mainflux-jaeger | {"level":"info","ts":1629075087.2717173,"caller":"server/grpc.go:76","msg":"Starting jaeger-collector gRPC server","grpc.host-port":":14250"} mainflux-jaeger | {"level":"info","ts":1629075087.2717621,"caller":"server/http.go:44","msg":"Starting jaeger-collector HTTP server","http host-port":":14268"} mainflux-jaeger | {"level":"info","ts":1629075087.2718732,"caller":"server/zipkin.go:48","msg":"Listening for Zipkin HTTP traffic","zipkin host-port":":0"} mainflux-jaeger | {"level":"info","ts":1629075087.352679,"caller":"grpc/builder.go:67","msg":"Agent requested insecure grpc connection to collector(s)"} mainflux-jaeger | {"level":"info","ts":1629075087.3551996,"caller":"grpc@v1.29.1/clientconn.go:243","msg":"parsed scheme: \"\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3552217,"caller":"grpc@v1.29.1/clientconn.go:249","msg":"scheme \"\" not registered, fallback to default scheme","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3552701,"caller":"grpc@v1.29.1/resolver_conn_wrapper.go:143","msg":"ccResolverWrapper: sending update to cc: {[{:14250 0 }] }","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3553097,"caller":"grpc@v1.29.1/clientconn.go:667","msg":"ClientConn switching balancer to \"round_robin\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3553326,"caller":"grpc@v1.29.1/clientconn.go:682","msg":"Channel switches to new LB policy \"round_robin\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3554037,"caller":"grpc@v1.29.1/clientconn.go:1056","msg":"Subchannel Connectivity change to CONNECTING","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3555734,"caller":"grpc@v1.29.1/clientconn.go:1193","msg":"Subchannel picks a new address \":14250\" to connect","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3563957,"caller":"grpc@v1.29.1/clientconn.go:417","msg":"Channel Connectivity change to CONNECTING","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3564358,"caller":"grpc/builder.go:101","msg":"Checking connection to collector"} mainflux-jaeger | {"level":"info","ts":1629075087.3564422,"caller":"grpc/builder.go:104","msg":"Agent collector connection state change","dialTarget":":14250","status":"CONNECTING"} mainflux-jaeger | {"level":"info","ts":1629075087.359443,"caller":"grpc@v1.29.1/clientconn.go:1056","msg":"Subchannel Connectivity change to READY","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595428,"caller":"base/balancer.go:200","msg":"roundrobinPicker: newPicker called with info: {map[0xc00029fd60:{{:14250 0 }}]}","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595572,"caller":"grpc@v1.29.1/clientconn.go:417","msg":"Channel Connectivity change to READY","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595638,"caller":"grpc/builder.go:104","msg":"Agent collector connection state change","dialTarget":":14250","status":"READY"} mainflux-jaeger | {"level":"info","ts":1629075087.3619275,"caller":"command-line-arguments/main.go:212","msg":"Starting agent"} mainflux-jaeger | {"level":"info","ts":1629075087.3623028,"caller":"querysvc/query_service.go:137","msg":"Archive storage not created","reason":"archive storage not supported"} mainflux-jaeger | {"level":"info","ts":1629075087.362369,"caller":"app/agent.go:69","msg":"Starting jaeger-agent HTTP server","http-port":5778} mainflux-jaeger | {"level":"info","ts":1629075087.3624976,"caller":"app/flags.go:143","msg":"Archive storage not initialized"} mainflux-jaeger | {"level":"info","ts":1629075087.3650594,"caller":"app/server.go:163","msg":"Query server started","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3651648,"caller":"healthcheck/handler.go:128","msg":"Health Check state change","status":"ready"} mainflux-jaeger | {"level":"info","ts":1629075087.3653233,"caller":"app/server.go:208","msg":"Starting HTTP server","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3653343,"caller":"app/server.go:221","msg":"Starting GRPC server","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3653417,"caller":"app/server.go:232","msg":"Starting CMUX server","port":16686,"addr":":16686"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 360.986487ms","ts":"2021-08-16T00:51:32.269395171Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.10238282s","ts":"2021-08-16T00:51:32.632764346Z"} mainflux-nats | [1] 2021/08/16 00:51:26.425542 [INF] Starting nats-server mainflux-nats | [1] 2021/08/16 00:51:26.425602 [INF] Version: 2.2.4 mainflux-nats | [1] 2021/08/16 00:51:26.425603 [INF] Git: [924b314] mainflux-nats | [1] 2021/08/16 00:51:26.425605 [INF] Name: NBTJ52DKFCNNP4R6UETDHWT7PMH3PAL5G472IWZOBLECA2LNCH4GVBXI mainflux-nats | [1] 2021/08/16 00:51:26.425606 [INF] ID: NBTJ52DKFCNNP4R6UETDHWT7PMH3PAL5G472IWZOBLECA2LNCH4GVBXI mainflux-nats | [1] 2021/08/16 00:51:26.425612 [INF] Using configuration file: /etc/nats/nats.conf mainflux-nats | [1] 2021/08/16 00:51:26.428655 [INF] Listening for client connections on 0.0.0.0:4222 mainflux-nats | [1] 2021/08/16 00:51:26.428823 [INF] Server is ready mainflux-things | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.9:5432: connect: connection refused","ts":"2021-08-16T00:51:29.267218848Z"} mainflux-things-db | The files belonging to this database system will be owned by user "postgres". mainflux-things-db | This user must also own the server process. mainflux-things-db | mainflux-things-db | The database cluster will be initialized with locale "en_US.utf8". mainflux-things-db | The default database encoding has accordingly been set to "UTF8". mainflux-things-db | The default text search configuration will be set to "english". mainflux-things-db | mainflux-things-db | Data page checksums are disabled. mainflux-things-db | mainflux-things-db | fixing permissions on existing directory /var/lib/postgresql/data ... ok mainflux-things-db | creating subdirectories ... ok mainflux-things-db | selecting dynamic shared memory implementation ... posix mainflux-things-db | selecting default max_connections ... 100 mainflux-things-db | selecting default shared_buffers ... 128MB mainflux-things-db | selecting default time zone ... UTC mainflux-things-db | creating configuration files ... ok mainflux-things-db | running bootstrap script ... ok mainflux-things-db | performing post-bootstrap initialization ... sh: locale: not found mainflux-things-db | 2021-08-16 00:51:29.185 UTC [30] WARNING: no usable system locales were found mainflux-things-db | ok mainflux-things-db | syncing data to disk ... ok mainflux-things-db | mainflux-things-db | mainflux-things-db | Success. You can now start the database server using: mainflux-things-db | mainflux-things-db | pg_ctl -D /var/lib/postgresql/data -l logfile start mainflux-things-db | mainflux-things-db | initdb: warning: enabling "trust" authentication for local connections mainflux-things-db | You can change this by editing pg_hba.conf or using the option -A, or mainflux-things-db | --auth-local and --auth-host, the next time you run initdb. mainflux-things-db | waiting for server to start....2021-08-16 00:51:32.071 UTC [35] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-things-db | 2021-08-16 00:51:32.086 UTC [35] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-things-db | 2021-08-16 00:51:32.089 UTC [36] LOG: database system was shut down at 2021-08-16 00:51:31 UTC mainflux-things-db | 2021-08-16 00:51:32.093 UTC [35] LOG: database system is ready to accept connections mainflux-things-db | done mainflux-things-db | server started mainflux-things-db | CREATE DATABASE mainflux-things-db | mainflux-things-db | mainflux-things-db | /usr/local/bin/docker-entrypoint.sh: ignoring /docker-entrypoint-initdb.d/ mainflux-things-db | mainflux-things-db | 2021-08-16 00:51:32.674 UTC [35] LOG: received fast shutdown request mainflux-things-db | waiting for server to shut down...2021-08-16 00:51:32.674 UTC [35] LOG: aborting any active transactions mainflux-things-db | 2021-08-16 00:51:32.675 UTC [35] LOG: background worker "logical replication launcher" (PID 42) exited with exit code 1 mainflux-things-db | .2021-08-16 00:51:32.681 UTC [37] LOG: shutting down mainflux-things-db | 2021-08-16 00:51:32.727 UTC [35] LOG: database system is shut down mainflux-things-db | done mainflux-things-db | server stopped mainflux-things-db | mainflux-things-db | PostgreSQL init process complete; ready for start up. mainflux-things-db | mainflux-things-db | 2021-08-16 00:51:32.819 UTC [1] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-things-db | 2021-08-16 00:51:32.822 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-things-db | 2021-08-16 00:51:32.822 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-things-db | 2021-08-16 00:51:32.841 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-things-db | 2021-08-16 00:51:32.868 UTC [49] LOG: database system was shut down at 2021-08-16 00:51:32 UTC mainflux-things-db | 2021-08-16 00:51:32.883 UTC [1] LOG: database system is ready to accept connections mainflux-users | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.6:5432: connect: connection refused","ts":"2021-08-16T00:51:29.430145584Z"} mainflux-users-db | The files belonging to this database system will be owned by user "postgres". mainflux-users-db | This user must also own the server process. mainflux-users-db | mainflux-users-db | The database cluster will be initialized with locale "en_US.utf8". mainflux-users-db | The default database encoding has accordingly been set to "UTF8". mainflux-users-db | The default text search configuration will be set to "english". mainflux-users-db | mainflux-users-db | Data page checksums are disabled. mainflux-users-db | mainflux-users-db | fixing permissions on existing directory /var/lib/postgresql/data ... ok mainflux-users-db | creating subdirectories ... ok mainflux-users-db | selecting dynamic shared memory implementation ... posix mainflux-users-db | selecting default max_connections ... 100 mainflux-users-db | selecting default shared_buffers ... 128MB mainflux-users-db | selecting default time zone ... UTC mainflux-users-db | creating configuration files ... ok mainflux-users-db | running bootstrap script ... ok mainflux-users-db | performing post-bootstrap initialization ... sh: locale: not found mainflux-users-db | 2021-08-16 00:51:29.215 UTC [30] WARNING: no usable system locales were found mainflux-users-db | ok mainflux-users-db | syncing data to disk ... ok mainflux-users-db | mainflux-users-db | mainflux-users-db | Success. You can now start the database server using: mainflux-users-db | mainflux-users-db | pg_ctl -D /var/lib/postgresql/data -l logfile start mainflux-users-db | mainflux-users-db | initdb: warning: enabling "trust" authentication for local connections mainflux-users-db | You can change this by editing pg_hba.conf or using the option -A, or mainflux-users-db | --auth-local and --auth-host, the next time you run initdb. mainflux-users-db | waiting for server to start....2021-08-16 00:51:32.341 UTC [35] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-users-db | 2021-08-16 00:51:32.347 UTC [35] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-users-db | 2021-08-16 00:51:32.352 UTC [36] LOG: database system was shut down at 2021-08-16 00:51:31 UTC mainflux-users-db | 2021-08-16 00:51:32.363 UTC [35] LOG: database system is ready to accept connections mainflux-users-db | done mainflux-users-db | server started mainflux-users-db | CREATE DATABASE mainflux-users-db | mainflux-users-db | mainflux-users-db | /usr/local/bin/docker-entrypoint.sh: ignoring /docker-entrypoint-initdb.d/ mainflux-users-db | mainflux-users-db | 2021-08-16 00:51:32.741 UTC [35] LOG: received fast shutdown request mainflux-users-db | waiting for server to shut down....2021-08-16 00:51:32.742 UTC [35] LOG: aborting any active transactions mainflux-users-db | 2021-08-16 00:51:32.744 UTC [35] LOG: background worker "logical replication launcher" (PID 42) exited with exit code 1 mainflux-users-db | 2021-08-16 00:51:32.751 UTC [37] LOG: shutting down mainflux-users-db | 2021-08-16 00:51:32.767 UTC [35] LOG: database system is shut down mainflux-users-db | done mainflux-users-db | server stopped mainflux-users-db | mainflux-users-db | PostgreSQL init process complete; ready for start up. mainflux-users-db | mainflux-users-db | 2021-08-16 00:51:32.882 UTC [1] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-users-db | 2021-08-16 00:51:32.898 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-users-db | 2021-08-16 00:51:32.898 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-users-db | 2021-08-16 00:51:32.907 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-users-db | 2021-08-16 00:51:32.909 UTC [49] LOG: database system was shut down at 2021-08-16 00:51:32 UTC mainflux-users-db | 2021-08-16 00:51:32.911 UTC [1] LOG: database system is ready to accept connections mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.082994179s","ts":"2021-08-16T00:51:33.73936897Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.909572032s","ts":"2021-08-16T00:51:34.823610687Z"} mainflux-vernemq | config is OK mainflux-vernemq | -config /vernemq/data/generated.configs/app.2021.08.16.00.51.34.config -args_file /vernemq/bin/../etc/vm.args -vm_args /vernemq/bin/../etc/vm.args mainflux-vernemq | Exec: /vernemq/bin/../erts-10.7.2.7/bin/erlexec -boot /vernemq/bin/../releases/1.11.0/vernemq -config /vernemq/data/generated.configs/app.2021.08.16.00.51.34.config -args_file /vernemq/bin/../etc/vm.args -vm_args /vernemq/bin/../etc/vm.args -pa /vernemq/bin/../lib/erlio-patches -- console -noshell -noinput mainflux-vernemq | Root: /vernemq/bin/.. mainflux-mqtt | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:36.771046618Z"} mainflux-mqtt | {"level":"info","message":"Starting MQTT proxy on port 1883","ts":"2021-08-16T00:51:36.823969326Z"} mainflux-mqtt | {"level":"info","message":"Starting MQTT over WS proxy on port 8080","ts":"2021-08-16T00:51:36.824554951Z"}

mainflux-users-db | 2021-08-16 00:55:14.508 UTC [1] LOG: received fast shutdown request mainflux-users-db | 2021-08-16 00:55:14.513 UTC [1] LOG: aborting any active transactions mainflux-users-db | 2021-08-16 00:55:14.525 UTC [56] FATAL: terminating connection due to administrator command mainflux-users-db | 2021-08-16 00:55:14.539 UTC [1] LOG: background worker "logical replication launcher" (PID 55) exited with exit code 1 mainflux-users-db | 2021-08-16 00:55:14.542 UTC [50] LOG: shutting down mainflux-nats | [1] 2021/08/16 00:55:14.555434 [INF] Initiating Shutdown... mainflux-nats | [1] 2021/08/16 00:55:14.555682 [INF] Server Exiting.. mainflux-users-db | 2021-08-16 00:55:14.566 UTC [1] LOG: database system is shut down mainflux-auth-db | 2021-08-16 00:55:14.624 UTC [1] LOG: received fast shutdown request mainflux-auth-db | 2021-08-16 00:55:14.625 UTC [1] LOG: aborting any active transactions mainflux-auth-db | 2021-08-16 00:55:14.625 UTC [56] FATAL: terminating connection due to administrator command mainflux-auth-db | 2021-08-16 00:55:14.626 UTC [1] LOG: background worker "logical replication launcher" (PID 55) exited with exit code 1 mainflux-auth-db | 2021-08-16 00:55:14.627 UTC [50] LOG: shutting down mainflux-auth-db | 2021-08-16 00:55:14.653 UTC [1] LOG: database system is shut down mainflux-things-db | 2021-08-16 00:55:14.719 UTC [1] LOG: received fast shutdown request mainflux-things-db | 2021-08-16 00:55:14.719 UTC [1] LOG: aborting any active transactions mainflux-things-db | 2021-08-16 00:55:14.720 UTC [1] LOG: background worker "logical replication launcher" (PID 55) exited with exit code 1 mainflux-things-db | 2021-08-16 00:55:14.720 UTC [56] FATAL: terminating connection due to administrator command mainflux-things-db | 2021-08-16 00:55:14.723 UTC [50] LOG: shutting down mainflux-things-db | 2021-08-16 00:55:14.744 UTC [1] LOG: database system is shut down mainflux-auth-redis | 1:signal-handler (1629075314) Received SIGTERM scheduling shutdown... mainflux-auth-redis | 1:M 16 Aug 2021 00:55:14.847 # User requested shutdown... mainflux-auth-redis | 1:M 16 Aug 2021 00:55:14.847 Saving the final RDB snapshot before exiting. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:14.848 DB saved on disk mainflux-auth-redis | 1:M 16 Aug 2021 00:55:14.848 # Redis is now ready to exit, bye bye... mainflux-users-db exited with code 0 mainflux-nats exited with code 1 mainflux-auth-redis exited with code 0 mainflux-auth-db exited with code 0 mainflux-things-db exited with code 0 mainflux-nats | [1] 2021/08/16 00:55:19.793284 [INF] Starting nats-server mainflux-nats | [1] 2021/08/16 00:55:19.793381 [INF] Version: 2.2.4 mainflux-nats | [1] 2021/08/16 00:55:19.793384 [INF] Git: [924b314] mainflux-nats | [1] 2021/08/16 00:55:19.793386 [INF] Name: NACTZMS2FHKRSKNJIUT4ROJBN34E65R6EURJHFGYUTT27PKWNRRFLHYN mainflux-nats | [1] 2021/08/16 00:55:19.793387 [INF] ID: NACTZMS2FHKRSKNJIUT4ROJBN34E65R6EURJHFGYUTT27PKWNRRFLHYN mainflux-nats | [1] 2021/08/16 00:55:19.793394 [INF] Using configuration file: /etc/nats/nats.conf mainflux-nats | [1] 2021/08/16 00:55:19.795926 [INF] Listening for client connections on 0.0.0.0:4222 mainflux-nats | [1] 2021/08/16 00:55:19.796192 [INF] Server is ready mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.296 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.297 # Redis version=5.0.13, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.297 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 Running mode=standalone, port=6379. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # Server initialized mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # WARNING you have Transparent Huge Pages (THP) support enabled in your kernel. This will create latency and memory usage issues with Redis. To fix this issue run the command 'echo never > /sys/kernel/mm/transparent_hugepage/enabled' as root, and add it to your /etc/rc.local in order to retain the setting after a reboot. Redis must be restarted after THP is disabled. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 DB loaded from disk: 0.000 seconds mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 * Ready to accept connections mainflux-auth-db | mainflux-auth-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-auth-db | mainflux-things-db | mainflux-things-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-things-db | mainflux-users-db | mainflux-users-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-users-db | mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-auth-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-things-db | 2021-08-16 00:55:27.689 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-users-db | 2021-08-16 00:55:27.690 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-auth-db | 2021-08-16 00:55:27.692 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-auth-db | 2021-08-16 00:55:27.695 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-auth-db | 2021-08-16 00:55:27.697 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-auth-db | 2021-08-16 00:55:27.704 UTC [20] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-users-db | 2021-08-16 00:55:27.704 UTC [21] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-things-db | 2021-08-16 00:55:27.704 UTC [21] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-things-db | 2021-08-16 00:55:27.793 UTC [1] LOG: database system is ready to accept connections mainflux-users-db | 2021-08-16 00:55:27.793 UTC [1] LOG: database system is ready to accept connections mainflux-auth-db | 2021-08-16 00:55:27.798 UTC [1] LOG: database system is ready to accept connections mainflux-users exited with code 2 mainflux-users | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:55:29.652643475Z"} mainflux-users | {"level":"error","message":"Failed to configure e-mailing util: Parse e-mail template failed : read email.tmpl: is a directory","ts":"2021-08-16T00:55:29.685850208Z"} mainflux-nginx exited with code 0 mainflux-users | {"level":"info","message":"Users service started using http, exposed port 8180","ts":"2021-08-16T00:55:29.703379883Z"}

the cli log: 图片

the ui log:

ubuntu@ubuntu:~$ cd ui/ ubuntu@ubuntu:~/ui$ make run docker-compose -f docker/docker-compose.yml up Creating volume "docker_mainflux-influxdb-volume" with default driver Creating volume "docker_mainflux-bootstrap-db-volume" with default driver Creating volume "docker_mainflux-grafana-volume" with default driver Creating volume "docker_mainflux-opcua-adapter-volume" with default driver Creating volume "docker_mainflux-opcua-redis-volume" with default driver Creating volume "docker_mainflux-twins-db-volume" with default driver Creating volume "docker_mainflux-twins-db-configdb-volume" with default driver WARNING: Found orphan containers (mainflux-coap) for this project. If you removed or renamed this service in your compose file, you can run this command with the --remove-orphans flag to clean it up. mainflux-jaeger is up-to-date Creating mainflux-twins-db ... Creating mainflux-opcua-redis ... Creating mainflux-ui ... Creating mainflux-opcua-redis ... done Creating mainflux-ui ... done Creating mainflux-bootstrap-db ... done Creating mainflux-twins-db ... done Creating mainflux-provision ... done Recreating mainflux-nats ... done Recreating mainflux-auth-db ... done Recreating mainflux-users-db ... done Recreating mainflux-things-db ... done Creating mainflux-influxdb ... Creating mainflux-influxdb-reader ... done Creating mainflux-bootstrap ... mainflux-auth is up-to-date Creating mainflux-influxdb ... done mainflux-mqtt is up-to-date Creating mainflux-bootstrap ... done Recreating mainflux-users ... done Creating mainflux-influxdb-writer ... done Creating mainflux-opcua ... done Creating mainflux-twins ... done Creating mainflux-grafana ... done Recreating mainflux-nginx ... done Attaching to mainflux-jaeger, mainflux-es-redis, mainflux-vernemq, mainflux-opcua-redis, mainflux-bootstrap-db, mainflux-provision, mainflux-influxdb-reader, mainflux-ui, mainflux-auth-redis, mainflux-nats, mainflux-things-db, mainflux-auth-db, mainflux-auth, mainflux-things, mainflux-mqtt, mainflux-http, mainflux-users-db, mainflux-influxdb, mainflux-twins-db, mainflux-bootstrap, mainflux-opcua, mainflux-influxdb-writer, mainflux-twins, mainflux-users, mainflux-grafana, mainflux-nginx mainflux-auth-db | mainflux-auth-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-auth-db | mainflux-auth-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-auth-db | 2021-08-16 00:55:27.692 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-auth-db | 2021-08-16 00:55:27.695 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.296 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.297 # Redis version=5.0.13, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-auth-redis | 1:C 16 Aug 2021 00:55:20.297 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 Running mode=standalone, port=6379. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # Server initialized mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 # WARNING you have Transparent Huge Pages (THP) support enabled in your kernel. This will create latency and memory usage issues with Redis. To fix this issue run the command 'echo never > /sys/kernel/mm/transparent_hugepage/enabled' as root, and add it to your /etc/rc.local in order to retain the setting after a reboot. Redis must be restarted after THP is disabled. mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 DB loaded from disk: 0.000 seconds mainflux-auth-redis | 1:M 16 Aug 2021 00:55:20.308 Ready to accept connections mainflux-auth-db | 2021-08-16 00:55:27.697 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-auth-db | 2021-08-16 00:55:27.704 UTC [20] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-auth-db | 2021-08-16 00:55:27.798 UTC [1] LOG: database system is ready to accept connections mainflux-bootstrap | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:55:30.419289488Z"} mainflux-bootstrap | {"level":"info","message":"Bootstrap service started using http on port 8202","ts":"2021-08-16T00:55:30.447261455Z"} mainflux-bootstrap | {"level":"info","message":"Subscribed to Redis Event Store","ts":"2021-08-16T00:55:30.447696877Z"} mainflux-bootstrap-db | The files belonging to this database system will be owned by user "postgres". mainflux-bootstrap-db | This user must also own the server process. mainflux-bootstrap-db | mainflux-bootstrap-db | The database cluster will be initialized with locale "en_US.utf8". mainflux-bootstrap-db | The default database encoding has accordingly been set to "UTF8". mainflux-bootstrap-db | The default text search configuration will be set to "english". mainflux-bootstrap-db | mainflux-bootstrap-db | Data page checksums are disabled. mainflux-bootstrap-db | mainflux-bootstrap-db | fixing permissions on existing directory /var/lib/postgresql/data ... ok mainflux-bootstrap-db | creating subdirectories ... ok mainflux-bootstrap-db | selecting dynamic shared memory implementation ... posix mainflux-bootstrap-db | selecting default max_connections ... 100 mainflux-bootstrap-db | selecting default shared_buffers ... 128MB mainflux-bootstrap-db | selecting default time zone ... UTC mainflux-bootstrap-db | creating configuration files ... ok mainflux-bootstrap-db | running bootstrap script ... ok mainflux-bootstrap-db | performing post-bootstrap initialization ... sh: locale: not found mainflux-bootstrap-db | 2021-08-16 00:55:19.108 UTC [30] WARNING: no usable system locales were found mainflux-bootstrap-db | ok mainflux-bootstrap-db | syncing data to disk ... ok mainflux-bootstrap-db | mainflux-bootstrap-db | mainflux-bootstrap-db | Success. You can now start the database server using: mainflux-bootstrap-db | mainflux-bootstrap-db | pg_ctl -D /var/lib/postgresql/data -l logfile start mainflux-bootstrap-db | mainflux-bootstrap-db | waiting for server to start....2021-08-16 00:55:20.305 UTC [35] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-bootstrap-db | 2021-08-16 00:55:20.306 UTC [35] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-bootstrap-db | 2021-08-16 00:55:20.309 UTC [36] LOG: database system was shut down at 2021-08-16 00:55:20 UTC mainflux-bootstrap-db | 2021-08-16 00:55:20.311 UTC [35] LOG: database system is ready to accept connections mainflux-bootstrap-db | done mainflux-bootstrap-db | server started mainflux-bootstrap-db | initdb: warning: enabling "trust" authentication for local connections mainflux-bootstrap-db | You can change this by editing pg_hba.conf or using the option -A, or mainflux-bootstrap-db | --auth-local and --auth-host, the next time you run initdb. mainflux-bootstrap-db | 2021-08-16 00:55:20.643 UTC [1] LOG: starting PostgreSQL 13.3 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.3.1_git20210424) 10.3.1 20210424, 64-bit mainflux-bootstrap-db | 2021-08-16 00:55:20.643 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-bootstrap-db | 2021-08-16 00:55:20.643 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-bootstrap-db | 2021-08-16 00:55:20.644 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-bootstrap-db | 2021-08-16 00:55:20.647 UTC [49] LOG: database system was shut down at 2021-08-16 00:55:20 UTC mainflux-bootstrap-db | 2021-08-16 00:55:20.649 UTC [1] LOG: database system is ready to accept connections mainflux-bootstrap-db | CREATE DATABASE mainflux-bootstrap-db | mainflux-bootstrap-db | mainflux-bootstrap-db | /usr/local/bin/docker-entrypoint.sh: ignoring /docker-entrypoint-initdb.d/ mainflux-bootstrap-db | mainflux-bootstrap-db | waiting for server to shut down...2021-08-16 00:55:20.529 UTC [35] LOG: received fast shutdown request mainflux-bootstrap-db | .2021-08-16 00:55:20.529 UTC [35] LOG: aborting any active transactions mainflux-bootstrap-db | 2021-08-16 00:55:20.530 UTC [35] LOG: background worker "logical replication launcher" (PID 42) exited with exit code 1 mainflux-bootstrap-db | 2021-08-16 00:55:20.530 UTC [37] LOG: shutting down mainflux-bootstrap-db | 2021-08-16 00:55:20.535 UTC [35] LOG: database system is shut down mainflux-bootstrap-db | done mainflux-bootstrap-db | server stopped mainflux-bootstrap-db | mainflux-bootstrap-db | PostgreSQL init process complete; ready for start up. mainflux-bootstrap-db | mainflux-auth | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.2:5432: connect: connection refused","ts":"2021-08-16T00:51:27.788502337Z"} mainflux-auth | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.2:5432: connect: connection refused","ts":"2021-08-16T00:51:29.664403597Z"} mainflux-auth | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.2:5432: connect: connection refused","ts":"2021-08-16T00:51:33.040170456Z"} mainflux-auth | {"level":"info","message":"Authentication gRPC service started using http on port 8181","ts":"2021-08-16T00:51:34.198223058Z"} mainflux-auth | {"level":"info","message":"Authentication gRPC service started, exposed port 8181","ts":"2021-08-16T00:51:34.198408946Z"} mainflux-auth | {"level":"info","message":"Authentication service started using http, exposed port 8189","ts":"2021-08-16T00:51:34.207663809Z"} mainflux-auth | {"level":"info","message":"Method issue for the key with expiration date 2021-08-16 10:54:44.732181738 +0000 UTC took 3.960224ms to complete without errors.","ts":"2021-08-16T00:54:44.736149355Z"} mainflux-auth | {"level":"info","message":"Method identify took 198.899µs to complete without errors.","ts":"2021-08-16T00:54:44.785756149Z"} mainflux-auth | {"level":"info","message":"Method identify took 133.887µs to complete without errors.","ts":"2021-08-16T00:54:44.808586566Z"} mainflux-auth | {"level":"info","message":"Method identify took 62.463µs to complete without errors.","ts":"2021-08-16T00:54:44.817670482Z"} mainflux-auth | {"level":"info","message":"Method identify took 48.139µs to complete without errors.","ts":"2021-08-16T00:54:44.825485534Z"} mainflux-influxdb | influxdb init process in progress... mainflux-influxdb | ts=2021-08-16T00:55:29.570880Z lvl=info msg="InfluxDB starting" log_id=0V~78r8W000 version=1.8.5 branch=1.8 commit=3d16c6318cf5 mainflux-influxdb | ts=2021-08-16T00:55:29.570919Z lvl=info msg="Go runtime" log_id=0V~78r8W000 version=go1.13.8 maxprocs=2 mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # Redis version=6.2.2, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-es-redis | 1:C 16 Aug 2021 00:51:26.811 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 monotonic clock: POSIX clock_gettime mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 Running mode=standalone, port=6379. mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 # Server initialized mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.813 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-es-redis | 1:M 16 Aug 2021 00:51:26.815 * Ready to accept connections mainflux-influxdb | ts=2021-08-16T00:55:29.889540Z lvl=info msg="Using data dir" log_id=0V~78r8W000 service=store path=/var/lib/influxdb/data mainflux-influxdb | ts=2021-08-16T00:55:29.889622Z lvl=info msg="Compaction settings" log_id=0V~78r8W000 service=store max_concurrent_compactions=1 throughput_bytes_per_second=50331648 throughput_bytes_per_second_burst=50331648 mainflux-influxdb | ts=2021-08-16T00:55:29.912481Z lvl=info msg="Open store (start)" log_id=0V~78r8W000 service=store trace_id=0V~78sU0000 op_name=tsdb_open op_event=start mainflux-influxdb | ts=2021-08-16T00:55:29.912575Z lvl=info msg="Open store (end)" log_id=0V~78r8W000 service=store trace_id=0V~78sU0000 op_name=tsdb_open op_event=end op_elapsed=0.099ms mainflux-influxdb | ts=2021-08-16T00:55:30.016962Z lvl=info msg="Opened service" log_id=0V~78r8W000 service=subscriber mainflux-influxdb | ts=2021-08-16T00:55:30.017001Z lvl=info msg="Starting monitor service" log_id=0V~78r8W000 service=monitor mainflux-influxdb | ts=2021-08-16T00:55:30.017008Z lvl=info msg="Registered diagnostics client" log_id=0V~78r8W000 service=monitor name=build mainflux-influxdb | ts=2021-08-16T00:55:30.017011Z lvl=info msg="Registered diagnostics client" log_id=0V~78r8W000 service=monitor name=runtime mainflux-influxdb | ts=2021-08-16T00:55:30.017013Z lvl=info msg="Registered diagnostics client" log_id=0V~78r8W000 service=monitor name=network mainflux-influxdb | ts=2021-08-16T00:55:30.017019Z lvl=info msg="Registered diagnostics client" log_id=0V~78r8W000 service=monitor name=system mainflux-influxdb | ts=2021-08-16T00:55:30.022784Z lvl=info msg="Starting precreation service" log_id=0V~78r8W000 service=shard-precreation check_interval=10m advance_period=30m mainflux-influxdb | ts=2021-08-16T00:55:30.022849Z lvl=info msg="Starting snapshot service" log_id=0V~78r8W000 service=snapshot mainflux-influxdb | ts=2021-08-16T00:55:30.023118Z lvl=info msg="Starting continuous query service" log_id=0V~78r8W000 service=continuous_querier mainflux-influxdb-writer | {"level":"info","message":"Using SenML transformer","ts":"2021-08-16T00:55:30.015648533Z"} mainflux-influxdb-writer | {"level":"warn","message":"Failed to load subjects: unable to open configuration file : open /config.toml: no such file or directory","ts":"2021-08-16T00:55:30.015762351Z"} mainflux-influxdb-writer | {"level":"info","message":"InfluxDB writer service started, exposed port :8900","ts":"2021-08-16T00:55:30.015886116Z"} mainflux-http | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:31.922584979Z"} mainflux-http | {"level":"info","message":"HTTP adapter service started on port 8185","ts":"2021-08-16T00:51:31.969811667Z"} mainflux-influxdb | ts=2021-08-16T00:55:30.023270Z lvl=info msg="Starting HTTP service" log_id=0V~78r8W000 service=httpd authentication=false mainflux-influxdb | ts=2021-08-16T00:55:30.023293Z lvl=info msg="opened HTTP access log" log_id=0V~78r8W000 service=httpd path=stderr mainflux-influxdb | ts=2021-08-16T00:55:30.023399Z lvl=info msg="Listening on HTTP" log_id=0V~78r8W000 service=httpd addr=127.0.0.1:8086 https=false mainflux-influxdb | ts=2021-08-16T00:55:30.105702Z lvl=info msg="Starting retention policy enforcement service" log_id=0V~78r8W000 service=retention check_interval=30m mainflux-influxdb | ts=2021-08-16T00:55:30.105836Z lvl=info msg="Listening for signals" log_id=0V~78r8W000 mainflux-influxdb | ts=2021-08-16T00:55:30.109588Z lvl=info msg="Sending usage statistics to usage.influxdata.com" log_id=0V~78r8W000 mainflux-influxdb | ts=2021-08-16T00:55:30.312762Z lvl=info msg="Storing statistics" log_id=0V~78r8W000 service=monitor db_instance=_internal db_rp=monitor interval=10s mainflux-influxdb-reader | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:55:23.95173498Z"} mainflux-influxdb-reader | {"level":"info","message":"InfluxDB reader service started, exposed port 8905","ts":"2021-08-16T00:55:24.737357677Z"} mainflux-nats | [1] 2021/08/16 00:55:19.793284 [INF] Starting nats-server mainflux-nats | [1] 2021/08/16 00:55:19.793381 [INF] Version: 2.2.4 mainflux-nats | [1] 2021/08/16 00:55:19.793384 [INF] Git: [924b314] mainflux-nats | [1] 2021/08/16 00:55:19.793386 [INF] Name: NACTZMS2FHKRSKNJIUT4ROJBN34E65R6EURJHFGYUTT27PKWNRRFLHYN mainflux-nats | [1] 2021/08/16 00:55:19.793387 [INF] ID: NACTZMS2FHKRSKNJIUT4ROJBN34E65R6EURJHFGYUTT27PKWNRRFLHYN mainflux-nats | [1] 2021/08/16 00:55:19.793394 [INF] Using configuration file: /etc/nats/nats.conf mainflux-nats | [1] 2021/08/16 00:55:19.795926 [INF] Listening for client connections on 0.0.0.0:4222 mainflux-nats | [1] 2021/08/16 00:55:19.796192 [INF] Server is ready mainflux-jaeger | 2021/08/16 00:51:27 maxprocs: Leaving GOMAXPROCS=2: CPU quota undefined mainflux-jaeger | {"level":"info","ts":1629075087.1965857,"caller":"flags/service.go:116","msg":"Mounting metrics handler on admin server","route":"/metrics"} mainflux-jaeger | {"level":"info","ts":1629075087.1983154,"caller":"flags/admin.go:120","msg":"Mounting health check on admin server","route":"/"} mainflux-jaeger | {"level":"info","ts":1629075087.1992738,"caller":"flags/admin.go:126","msg":"Starting admin HTTP server","http-addr":":14269"} mainflux-jaeger | {"level":"info","ts":1629075087.1992972,"caller":"flags/admin.go:112","msg":"Admin server started","http.host-port":"[::]:14269","health-status":"unavailable"} mainflux-jaeger | {"level":"info","ts":1629075087.206957,"caller":"memory/factory.go:61","msg":"Memory storage initialized","configuration":{"MaxTraces":0}} mainflux-jaeger | {"level":"info","ts":1629075087.2717173,"caller":"server/grpc.go:76","msg":"Starting jaeger-collector gRPC server","grpc.host-port":":14250"} mainflux-jaeger | {"level":"info","ts":1629075087.2717621,"caller":"server/http.go:44","msg":"Starting jaeger-collector HTTP server","http host-port":":14268"} mainflux-jaeger | {"level":"info","ts":1629075087.2718732,"caller":"server/zipkin.go:48","msg":"Listening for Zipkin HTTP traffic","zipkin host-port":":0"} mainflux-jaeger | {"level":"info","ts":1629075087.352679,"caller":"grpc/builder.go:67","msg":"Agent requested insecure grpc connection to collector(s)"} mainflux-jaeger | {"level":"info","ts":1629075087.3551996,"caller":"grpc@v1.29.1/clientconn.go:243","msg":"parsed scheme: \"\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3552217,"caller":"grpc@v1.29.1/clientconn.go:249","msg":"scheme \"\" not registered, fallback to default scheme","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3552701,"caller":"grpc@v1.29.1/resolver_conn_wrapper.go:143","msg":"ccResolverWrapper: sending update to cc: {[{:14250 0 }] }","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3553097,"caller":"grpc@v1.29.1/clientconn.go:667","msg":"ClientConn switching balancer to \"round_robin\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3553326,"caller":"grpc@v1.29.1/clientconn.go:682","msg":"Channel switches to new LB policy \"round_robin\"","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3554037,"caller":"grpc@v1.29.1/clientconn.go:1056","msg":"Subchannel Connectivity change to CONNECTING","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3555734,"caller":"grpc@v1.29.1/clientconn.go:1193","msg":"Subchannel picks a new address \":14250\" to connect","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3563957,"caller":"grpc@v1.29.1/clientconn.go:417","msg":"Channel Connectivity change to CONNECTING","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3564358,"caller":"grpc/builder.go:101","msg":"Checking connection to collector"} mainflux-jaeger | {"level":"info","ts":1629075087.3564422,"caller":"grpc/builder.go:104","msg":"Agent collector connection state change","dialTarget":":14250","status":"CONNECTING"} mainflux-jaeger | {"level":"info","ts":1629075087.359443,"caller":"grpc@v1.29.1/clientconn.go:1056","msg":"Subchannel Connectivity change to READY","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595428,"caller":"base/balancer.go:200","msg":"roundrobinPicker: newPicker called with info: {map[0xc00029fd60:{{:14250 0 }}]}","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595572,"caller":"grpc@v1.29.1/clientconn.go:417","msg":"Channel Connectivity change to READY","system":"grpc","grpc_log":true} mainflux-jaeger | {"level":"info","ts":1629075087.3595638,"caller":"grpc/builder.go:104","msg":"Agent collector connection state change","dialTarget":":14250","status":"READY"} mainflux-jaeger | {"level":"info","ts":1629075087.3619275,"caller":"command-line-arguments/main.go:212","msg":"Starting agent"} mainflux-jaeger | {"level":"info","ts":1629075087.3623028,"caller":"querysvc/query_service.go:137","msg":"Archive storage not created","reason":"archive storage not supported"} mainflux-jaeger | {"level":"info","ts":1629075087.362369,"caller":"app/agent.go:69","msg":"Starting jaeger-agent HTTP server","http-port":5778} mainflux-jaeger | {"level":"info","ts":1629075087.3624976,"caller":"app/flags.go:143","msg":"Archive storage not initialized"} mainflux-jaeger | {"level":"info","ts":1629075087.3650594,"caller":"app/server.go:163","msg":"Query server started","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3651648,"caller":"healthcheck/handler.go:128","msg":"Health Check state change","status":"ready"} mainflux-jaeger | {"level":"info","ts":1629075087.3653233,"caller":"app/server.go:208","msg":"Starting HTTP server","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3653343,"caller":"app/server.go:221","msg":"Starting GRPC server","port":16686,"addr":":16686"} mainflux-jaeger | {"level":"info","ts":1629075087.3653417,"caller":"app/server.go:232","msg":"Starting CMUX server","port":16686,"addr":":16686"} mainflux-opcua | {"level":"info","message":"Connected to thing Redis Route-map","ts":"2021-08-16T00:55:30.357156382Z"} mainflux-opcua | {"level":"info","message":"Connected to channel Redis Route-map","ts":"2021-08-16T00:55:30.357199442Z"} mainflux-opcua | {"level":"info","message":"Connected to connection Redis Route-map","ts":"2021-08-16T00:55:30.357205027Z"} mainflux-opcua | {"level":"info","message":"opcua-adapter service started, exposed port 8188","ts":"2021-08-16T00:55:30.397611857Z"} mainflux-opcua | {"level":"warn","message":"Read stored subscriptions failed: file not found : stat /store/nodes.csv: no such file or directory","ts":"2021-08-16T00:55:30.398166926Z"} mainflux-opcua-redis | 1:C 16 Aug 2021 00:55:17.572 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo mainflux-opcua-redis | 1:C 16 Aug 2021 00:55:17.572 # Redis version=6.2.2, bits=64, commit=00000000, modified=0, pid=1, just started mainflux-opcua-redis | 1:C 16 Aug 2021 00:55:17.572 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf mainflux-opcua-redis | 1:M 16 Aug 2021 00:55:17.572 monotonic clock: POSIX clock_gettime mainflux-opcua-redis | 1:M 16 Aug 2021 00:55:17.584 Running mode=standalone, port=6379. mainflux-opcua-redis | 1:M 16 Aug 2021 00:55:17.584 # Server initialized mainflux-opcua-redis | 1:M 16 Aug 2021 00:55:17.584 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect. mainflux-opcua-redis | 1:M 16 Aug 2021 00:55:17.584 Ready to accept connections mainflux-provision | {"level":"info","message":"Continue with settings from file: /configs/config.toml","ts":"2021-08-16T00:55:17.980625661Z"} mainflux-provision | {"level":"info","message":"Provision service started using http on port 8190","ts":"2021-08-16T00:55:17.981543271Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 360.986487ms","ts":"2021-08-16T00:51:32.269395171Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.10238282s","ts":"2021-08-16T00:51:32.632764346Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.082994179s","ts":"2021-08-16T00:51:33.73936897Z"} mainflux-mqtt | {"level":"info","message":"Broker not ready: Get \"http://vernemq:8888/health\": dial tcp 172.18.0.7:8888: connect: connection refused, next try in 1.909572032s","ts":"2021-08-16T00:51:34.823610687Z"} mainflux-mqtt | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:36.771046618Z"} mainflux-mqtt | {"level":"info","message":"Starting MQTT proxy on port 1883","ts":"2021-08-16T00:51:36.823969326Z"} mainflux-mqtt | {"level":"info","message":"Starting MQTT over WS proxy on port 8080","ts":"2021-08-16T00:51:36.824554951Z"} mainflux-things-db | mainflux-things-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-things-db | mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-things-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-things-db | 2021-08-16 00:55:27.689 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-things-db | 2021-08-16 00:55:27.704 UTC [21] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-things-db | 2021-08-16 00:55:27.793 UTC [1] LOG: database system is ready to accept connections mainflux-things | {"level":"error","message":"Failed to connect to postgres: dial tcp 172.18.0.9:5432: connect: connection refused","ts":"2021-08-16T00:51:29.267218848Z"} mainflux-things | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:51:33.194824922Z"} mainflux-things | {"level":"info","message":"Things service started using http on port 8182","ts":"2021-08-16T00:51:33.207632609Z"} mainflux-things | {"level":"info","message":"Things service started using http on port 8182","ts":"2021-08-16T00:51:33.207975774Z"} mainflux-things | {"level":"info","message":"Things gRPC service started using http on port 8183","ts":"2021-08-16T00:51:33.208093856Z"} mainflux-things | {"level":"info","message":"Method create_things for token eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE2MjkxMTEyODQsImlhdCI6MTYyOTA3NTI4NCwiaXNzIjoibWFpbmZsdXguYXV0aCIsInN1YiI6Im11c2luZ19jaGFuZHJhc2VraGFyQGVtYWlsLmNvbSIsImlzc3Vlcl9pZCI6IjdiYWFkZGU5LWE5MDctNDBjNy05OGYxLTUxMWZhYTI4ZDgwYSIsInR5cGUiOjB9.OrV-fqBgTtIgZjWlSj_ElG_y58UQcrBfbf5Vv_XeaZY and things [{5ae17554-b462-449e-9109-6206f3b9cee2 musing_chandrasekhar@email.com d0 a7bf3543-bc92-48cd-a29f-9ac6abbb2fce map[]} {c98722a5-35db-46b5-8271-0a298d64a39b musing_chandrasekhar@email.com d1 b7e6f6f0-d6fe-49e9-9993-60d473b49d58 map[]}] took 32.580429ms to complete without errors.","ts":"2021-08-16T00:54:44.805278053Z"} mainflux-things | {"level":"info","message":"Method create_channels for token eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE2MjkxMTEyODQsImlhdCI6MTYyOTA3NTI4NCwiaXNzIjoibWFpbmZsdXguYXV0aCIsInN1YiI6Im11c2luZ19jaGFuZHJhc2VraGFyQGVtYWlsLmNvbSIsImlzc3Vlcl9pZCI6IjdiYWFkZGU5LWE5MDctNDBjNy05OGYxLTUxMWZhYTI4ZDgwYSIsInR5cGUiOjB9.OrV-fqBgTtIgZjWlSj_ElG_y58UQcrBfbf5Vv_XeaZY and channels [{8f0f503b-a9b6-47e1-ab77-65fc04366152 musing_chandrasekhar@email.com c0 map[]} {6a05ed40-3292-4174-8b1a-9d78aee71ed1 musing_chandrasekhar@email.com c1 map[]}] took 6.916665ms to complete without errors.","ts":"2021-08-16T00:54:44.81471338Z"} mainflux-things | {"level":"info","message":"Method connect for token eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE2MjkxMTEyODQsImlhdCI6MTYyOTA3NTI4NCwiaXNzIjoibWFpbmZsdXguYXV0aCIsInN1YiI6Im11c2luZ19jaGFuZHJhc2VraGFyQGVtYWlsLmNvbSIsImlzc3Vlcl9pZCI6IjdiYWFkZGU5LWE5MDctNDBjNy05OGYxLTUxMWZhYTI4ZDgwYSIsInR5cGUiOjB9.OrV-fqBgTtIgZjWlSj_ElG_y58UQcrBfbf5Vv_XeaZY, channels [8f0f503b-a9b6-47e1-ab77-65fc04366152 6a05ed40-3292-4174-8b1a-9d78aee71ed1] and things [5ae17554-b462-449e-9109-6206f3b9cee2] took 6.730726ms to complete without errors.","ts":"2021-08-16T00:54:44.82382888Z"} mainflux-things | {"level":"info","message":"Method connect for token eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJleHAiOjE2MjkxMTEyODQsImlhdCI6MTYyOTA3NTI4NCwiaXNzIjoibWFpbmZsdXguYXV0aCIsInN1YiI6Im11c2luZ19jaGFuZHJhc2VraGFyQGVtYWlsLmNvbSIsImlzc3Vlcl9pZCI6IjdiYWFkZGU5LWE5MDctNDBjNy05OGYxLTUxMWZhYTI4ZDgwYSIsInR5cGUiOjB9.OrV-fqBgTtIgZjWlSj_ElG_y58UQcrBfbf5Vv_XeaZY, channels [8f0f503b-a9b6-47e1-ab77-65fc04366152] and things [c98722a5-35db-46b5-8271-0a298d64a39b] took 2.464882ms to complete without errors.","ts":"2021-08-16T00:54:44.827525476Z"} mainflux-users | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:55:29.652643475Z"} mainflux-users | {"level":"error","message":"Failed to configure e-mailing util: Parse e-mail template failed : read email.tmpl: is a directory","ts":"2021-08-16T00:55:29.685850208Z"} mainflux-users | {"level":"info","message":"Users service started using http, exposed port 8180","ts":"2021-08-16T00:55:29.703379883Z"} mainflux-users-db | mainflux-users-db | PostgreSQL Database directory appears to contain a database; Skipping initialization mainflux-users-db | mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: starting PostgreSQL 13.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 10.2.1_pre1) 10.2.1 20201203, 64-bit mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv4 address "0.0.0.0", port 5432 mainflux-users-db | 2021-08-16 00:55:27.688 UTC [1] LOG: listening on IPv6 address "::", port 5432 mainflux-users-db | 2021-08-16 00:55:27.690 UTC [1] LOG: listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432" mainflux-users-db | 2021-08-16 00:55:27.704 UTC [21] LOG: database system was shut down at 2021-08-16 00:55:14 UTC mainflux-users-db | 2021-08-16 00:55:27.793 UTC [1] LOG: database system is ready to accept connections mainflux-vernemq | config is OK mainflux-vernemq | -config /vernemq/data/generated.configs/app.2021.08.16.00.51.34.config -args_file /vernemq/bin/../etc/vm.args -vm_args /vernemq/bin/../etc/vm.args mainflux-vernemq | Exec: /vernemq/bin/../erts-10.7.2.7/bin/erlexec -boot /vernemq/bin/../releases/1.11.0/vernemq -config /vernemq/data/generated.configs/app.2021.08.16.00.51.34.config -args_file /vernemq/bin/../etc/vm.args -vm_args /vernemq/bin/../etc/vm.args -pa /vernemq/bin/../lib/erlio-patches -- console -noshell -noinput mainflux-vernemq | Root: /vernemq/bin/.. mainflux-influxdb | [httpd] 127.0.0.1 - - [16/Aug/2021:00:55:30 +0000] "GET /ping HTTP/1.1" 204 0 "-" "InfluxDBShell/1.8.5" a73e29bc-fe2c-11eb-8001-0242ac120005 366948 mainflux-influxdb | ts=2021-08-16T00:55:30.698308Z lvl=info msg="Executing query" log_id=0V~78r8W000 service=query query="CREATE DATABASE mainflux" mainflux-influxdb | [httpd] 127.0.0.1 - - [16/Aug/2021:00:55:30 +0000] "POST /query?chunked=true&db=&epoch=ns&q=CREATE+DATABASE+mainflux HTTP/1.1 " 200 57 "-" "InfluxDBShell/1.8.5" a77637d7-fe2c-11eb-8002-0242ac120005 326950 mainflux-influxdb | /init-influxdb.sh: ignoring /docker-entrypoint-initdb.d/ mainflux-influxdb | mainflux-influxdb | ts=2021-08-16T00:55:30.978830Z lvl=info msg="Signal received, initializing clean shutdown..." log_id=0V~78r8W000 mainflux-influxdb | ts=2021-08-16T00:55:30.978870Z lvl=info msg="Waiting for clean shutdown..." log_id=0V~78r8W000 mainflux-influxdb | [tcp] 2021/08/16 00:55:30 tcp.Mux: Listener at 127.0.0.1:8088 failed failed to accept a connection, closing all listeners - accept tcp 127.0.0.1:8088: use of closed network connection mainflux-influxdb | ts=2021-08-16T00:55:30.979423Z lvl=info msg="Listener closed" log_id=0V~78r8W000 service=snapshot mainflux-influxdb | ts=2021-08-16T00:55:30.979466Z lvl=info msg="Shutting down monitor service" log_id=0V~78r8W000 service=monitor mainflux-influxdb | ts=2021-08-16T00:55:30.979483Z lvl=info msg="Terminating precreation service" log_id=0V~78r8W000 service=shard-precreation mainflux-influxdb | ts=2021-08-16T00:55:30.979520Z lvl=info msg="Terminating continuous query service" log_id=0V~78r8W000 service=continuous_querier mainflux-influxdb | ts=2021-08-16T00:55:30.979939Z lvl=info msg="Closing retention policy enforcement service" log_id=0V~78r8W000 service=retention mainflux-influxdb | ts=2021-08-16T00:55:30.980236Z lvl=info msg="Closed service" log_id=0V~78r8W000 service=subscriber mainflux-influxdb | ts=2021-08-16T00:55:31.010934Z lvl=info msg="Server shutdown completed" log_id=0V~78r8W000 mainflux-twins | {"level":"info","message":"gRPC communication is not encrypted","ts":"2021-08-16T00:55:31.081967005Z"} mainflux-twins | {"level":"info","message":"Twins service started using http on port 9021","ts":"2021-08-16T00:55:31.149833311Z"} mainflux-influxdb | ts=2021-08-16T00:55:31.188916Z lvl=info msg="InfluxDB starting" log_id=0V~78xT0000 version=1.8.5 branch=1.8 commit=3d16c6318cf5 mainflux-influxdb | ts=2021-08-16T00:55:31.188997Z lvl=info msg="Go runtime" log_id=0V~78xT0000 version=go1.13.8 maxprocs=2 mainflux-influxdb | ts=2021-08-16T00:55:31.289610Z lvl=info msg="Using data dir" log_id=0V~78xT0000 service=store path=/var/lib/influxdb/data mainflux-influxdb | ts=2021-08-16T00:55:31.289745Z lvl=info msg="Compaction settings" log_id=0V~78xT0000 service=store max_concurrent_compactions=1 throughput_bytes_per_second=50331648 throughput_bytes_per_second_burst=50331648 mainflux-influxdb | ts=2021-08-16T00:55:31.289771Z lvl=info msg="Open store (start)" log_id=0V~78xT0000 service=store trace_id=0V~78xrG001 op_name=tsdb_open op_event=start mainflux-influxdb | ts=2021-08-16T00:55:31.289901Z lvl=info msg="Open store (end)" log_id=0V~78xT0000 service=store trace_id=0V~78xrG001 op_name=tsdb_open op_event=end op_elapsed=0.131ms mainflux-influxdb | ts=2021-08-16T00:55:31.289989Z lvl=info msg="Opened service" log_id=0V~78xT0000 service=subscriber mainflux-influxdb | ts=2021-08-16T00:55:31.290025Z lvl=info msg="Starting monitor service" log_id=0V~78xT0000 service=monitor mainflux-influxdb | ts=2021-08-16T00:55:31.290054Z lvl=info msg="Registered diagnostics client" log_id=0V~78xT0000 service=monitor name=build mainflux-influxdb | ts=2021-08-16T00:55:31.290086Z lvl=info msg="Registered diagnostics client" log_id=0V~78xT0000 service=monitor name=runtime mainflux-influxdb | ts=2021-08-16T00:55:31.290166Z lvl=info msg="Registered diagnostics client" log_id=0V~78xT0000 service=monitor name=network mainflux-influxdb | ts=2021-08-16T00:55:31.290266Z lvl=info msg="Registered diagnostics client" log_id=0V~78xT0000 service=monitor name=system mainflux-influxdb | ts=2021-08-16T00:55:31.290400Z lvl=info msg="Starting precreation service" log_id=0V~78xT0000 service=shard-precreation check_interval=10m advance_period=30m mainflux-influxdb | ts=2021-08-16T00:55:31.290470Z lvl=info msg="Starting snapshot service" log_id=0V~78xT0000 service=snapshot mainflux-influxdb | ts=2021-08-16T00:55:31.290516Z lvl=info msg="Starting continuous query service" log_id=0V~78xT0000 service=continuous_querier mainflux-influxdb | ts=2021-08-16T00:55:31.290584Z lvl=info msg="Starting HTTP service" log_id=0V~78xT0000 service=httpd authentication=false mainflux-influxdb | ts=2021-08-16T00:55:31.290653Z lvl=info msg="opened HTTP access log" log_id=0V~78xT0000 service=httpd path=stderr mainflux-influxdb | ts=2021-08-16T00:55:31.290890Z lvl=info msg="Listening on HTTP" log_id=0V~78xT0000 service=httpd addr=[::]:8086 https=false mainflux-influxdb | ts=2021-08-16T00:55:31.290965Z lvl=info msg="Starting retention policy enforcement service" log_id=0V~78xT0000 service=retention check_interval=30m mainflux-influxdb | ts=2021-08-16T00:55:31.291087Z lvl=info msg="Listening for signals" log_id=0V~78xT0000 mainflux-influxdb | ts=2021-08-16T00:55:31.291297Z lvl=info msg="Storing statistics" log_id=0V~78xT0000 service=monitor db_instance=_internal db_rp=monitor interval=10s mainflux-influxdb | ts=2021-08-16T00:55:31.324455Z lvl=info msg="Sending usage statistics to usage.influxdata.com" log_id=0V~78xT0000 mainflux-grafana | t=2021-08-16T00:55:32+0000 lvl=info msg="Starting Grafana" logger=server version=7.3.7 commit=1e261642f4 branch=HEAD compiled=2021-01-14T08:41:57+0000 mainflux-grafana | t=2021-08-16T00:55:32+0000 lvl=info msg="Config loaded from" logger=settings file=/usr/share/grafana/conf/defaults.ini mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config loaded from" logger=settings file=/etc/grafana/grafana.ini mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from command line" logger=settings arg="default.paths.data=/var/lib/grafana" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from command line" logger=settings arg="default.paths.logs=/var/log/grafana" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from command line" logger=settings arg="default.paths.plugins=/var/lib/grafana/plugins" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from command line" logger=settings arg="default.paths.provisioning=/etc/grafana/provisioning" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from command line" logger=settings arg="default.log.mode=console" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from Environment variable" logger=settings var="GF_PATHS_DATA=/var/lib/grafana" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from Environment variable" logger=settings var="GF_PATHS_LOGS=/var/log/grafana" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from Environment variable" logger=settings var="GF_PATHS_PLUGINS=/var/lib/grafana/plugins" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Config overridden from Environment variable" logger=settings var="GF_PATHS_PROVISIONING=/etc/grafana/provisioning" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Path Home" logger=settings path=/usr/share/grafana mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Path Data" logger=settings path=/var/lib/grafana mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Path Logs" logger=settings path=/var/log/grafana mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Path Plugins" logger=settings path=/var/lib/grafana/plugins mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Path Provisioning" logger=settings path=/etc/grafana/provisioning mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="App mode production" logger=settings mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Connecting to DB" logger=sqlstore dbtype=sqlite3 mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Creating SQLite database file" logger=sqlstore path=/var/lib/grafana/grafana.db mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Starting DB migrations" logger=migrator mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create migration_log table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create user table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index user.login" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.524+00:00"},"s":"I", "c":"CONTROL", "id":23285, "ctx":"main","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index user.email" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_user_login - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_user_email - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table user to user_v1 - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create user table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_user_login - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_user_email - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy data_source v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old table user_v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column help_flags1 to user table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update user table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add last_seen_at column to user" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add missing user data" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add is_disabled column to user" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index user.login/user.email" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create temp user table v1-7" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_email - v1-7" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_org_id - v1-7" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_code - v1-7" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_status - v1-7" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update temp_user table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_temp_user_email - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_temp_user_org_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_temp_user_code - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_temp_user_status - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table temp_user to temp_user_tmp_qwerty - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create temp_user v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_email - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_org_id - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_code - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_temp_user_status - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy temp_user v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop temp_user_tmp_qwerty" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Set created for temp users that will otherwise prematurely expire" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create star table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index star.user_id_dashboard_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create org table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_org_name - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create org_user table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_org_user_org_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_org_user_org_id_user_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update org table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update org_user table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Migrate all Read Only Viewers to Viewers" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index dashboard.account_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index dashboard_account_id_slug" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_tag table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index dashboard_tag.dasboard_id_term" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_dashboard_tag_dashboard_id_term - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table dashboard to dashboard_v1 - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard v2" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.732+00:00"},"s":"W", "c":"ASIO", "id":22601, "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_dashboard_org_id - v2" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.733+00:00"},"s":"I", "c":"NETWORK", "id":4648601, "ctx":"main","msg":"Implicit TCP FastOpen unavailable. If TCP FastOpen is required, set tcpFastOpenServer, tcpFastOpenClient, and tcpFastOpenQueueSize."} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_dashboard_org_id_slug - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy dashboard v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop table dashboard_v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="alter dashboard.data to mediumtext v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column updated_by in dashboard - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column created_by in dashboard - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column gnetId in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for gnetId in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column plugin_id in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for plugin_id in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for dashboard_id in dashboard_tag" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update dashboard table charset" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.748+00:00"},"s":"I", "c":"STORAGE", "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":1,"port":27018,"dbPath":"/data/db","architecture":"64-bit","host":"ecb00660c186"}} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update dashboard_tag table charset" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.749+00:00"},"s":"I", "c":"CONTROL", "id":23403, "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"4.4.6","gitVersion":"72e66213c2c3eab37d9358d5e78ad7f5c1d0d0d7","openSSLVersion":"OpenSSL 1.1.1 11 Sep 2018","modules":[],"allocator":"tcmalloc","environment":{"distmod":"ubuntu1804","distarch":"x86_64","target_arch":"x86_64"}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.749+00:00"},"s":"I", "c":"CONTROL", "id":51765, "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"Ubuntu","version":"18.04"}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.749+00:00"},"s":"I", "c":"CONTROL", "id":21951, "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"net":{"bindIp":"*","port":27018}}}} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column folder_id in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column isFolder in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column has_acl in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column uid in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update uid column values in dashboard" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index dashboard_org_id_uid" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Remove unique index org_id_slug" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update dashboard title length" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index for dashboard_org_id_title_folder_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_provisioning" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table dashboard_provisioning to dashboard_provisioning_tmp_qwerty - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_provisioning v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_dashboard_provisioning_dashboard_id - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_dashboard_provisioning_dashboard_id_name - v2" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.770+00:00"},"s":"I", "c":"STORAGE", "id":22297, "ctx":"initandlisten","msg":"Using the XFS filesystem is strongly recommended with the WiredTiger storage engine. See http://dochub.mongodb.org/core/prodnotes-filesystem","tags":["startupWarnings"]} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy dashboard_provisioning v1 to v2" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:33.772+00:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=467M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,archive=true,path=journal,compressor=snappy),file_manager=(close_idle_time=100000,close_scan_interval=10,close_handle_minimum=250),statistics_log=(wait=0),verbose=[recovery_progress,checkpoint_progress,compact_progress],"}} mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop dashboard_provisioning_tmp_qwerty" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add check_sum column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for dashboard_title" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="delete tags for deleted dashboards" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="delete stars for deleted dashboards" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create data_source table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index data_source.account_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index data_source.account_id_name" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_data_source_account_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_data_source_account_id_name - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table data_source to data_source_v1 - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create data_source table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_data_source_org_id - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_data_source_org_id_name - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy data_source v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old table data_source_v1 #2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column with_credentials" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add secure json data column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update data_source table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update initial version to 1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add read_only data column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Migrate logging ds to loki ds" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update json_data with nulls" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add uid column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update uid value" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index datasource_org_id_uid" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create api_key table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index api_key.account_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index api_key.key" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index api_key.account_id_name" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_api_key_account_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_api_key_key - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index UQE_api_key_account_id_name - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table api_key to api_key_v1 - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create api_key table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_api_key_org_id - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_api_key_key - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_api_key_org_id_name - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy api_key v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old table api_key_v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update api_key table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add expires to api_key table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_snapshot table v4" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop table dashboard_snapshot_v4 #1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_snapshot table v5 #2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_dashboard_snapshot_key - v5" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_dashboard_snapshot_delete_key - v5" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_dashboard_snapshot_user_id - v5" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="alter dashboard_snapshot to mediumtext v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update dashboard_snapshot table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column external_delete_url to dashboard_snapshots table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add encrypted dashboard json column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Change dashboard_encrypted column to MEDIUMBLOB" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create quota table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_quota_org_id_user_id_target - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update quota table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create plugin_setting table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index UQE_plugin_setting_org_id_plugin_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column plugin_version to plugin_settings" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update plugin_setting table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create session table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old table playlist table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old table playlist_item table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create playlist table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create playlist item table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update playlist table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update playlist_item table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop preferences table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop preferences table v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create preferences table v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update preferences table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column team_id in preferences" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update team_id column values in preferences" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create alert table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index alert org_id & id " mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index alert state" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index alert dashboard_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Create alert_rule_tag table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index alert_rule_tag.alert_id_tag_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create alert_notification table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column is_default" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column frequency" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column send_reminder" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column disable_resolve_message" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index alert_notification org_id & name" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update alert table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update alert_notification table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create notification_journal table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index notification_journal org_id & alert_id & notifier_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop alert_notification_journal" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create alert_notification_state table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index alert_notification_state org_id & alert_id & notifier_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add for to alert table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column uid in alert_notification" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update uid column values in alert_notification" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index alert_notification_org_id_uid" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Remove unique index org_id_name" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column secure_settings in alert_notification" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="alter alert.settings to mediumtext" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add non-unique index alert_notification_state_alert_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add non-unique index alert_rule_tag_alert_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop old annotation table v4" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create annotation table v5" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index annotation 0 v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index annotation 1 v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index annotation 2 v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index annotation 3 v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index annotation 4 v3" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update annotation table charset" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column region_id to annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Drop category_id index" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column tags to annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Create annotation_tag table v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add unique index annotation_tag.annotation_id_tag_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Update alert annotations and set TEXT to empty" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add created time to annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add updated time to annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for created in annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for updated in annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Convert existing annotations from seconds to milliseconds" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add epoch_end column" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for epoch_end" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Make epoch_end the same as epoch" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Move region to single row" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Remove index org_id_epoch from annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Remove index org_id_dashboard_id_panel_id_epoch from annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for org_id_dashboard_id_epoch_end_epoch on annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for org_id_epoch_end_epoch on annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Remove index org_id_epoch_epoch_end from annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add index for alert_id on annotation table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create test_data table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard_version table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index dashboard_version.dashboard_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index dashboard_version.dashboard_id and dashboard_version.version" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Set dashboard version to 1 where 0" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="save existing dashboard data in dashboard_version table v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="alter dashboard_version.data to mediumtext v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create team table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index team.org_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index team_org_id_name" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create team member table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index team_member.org_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index team_member_org_id_team_id_user_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index team_member.team_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column email to team table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column external to team_member table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add column permission to team_member table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create dashboard acl table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index dashboard_acl_dashboard_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index dashboard_acl_dashboard_id_user_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index dashboard_acl_dashboard_id_team_id" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="save default acl rules in dashboard_acl table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="delete acl rules for deleted dashboards and folders" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create tag table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index tag.key_value" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create login attempt table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="add index login_attempt.username" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop index IDX_login_attempt_username - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Rename table login_attempt to login_attempt_tmp_qwerty - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create login_attempt v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_login_attempt_username - v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="copy login_attempt v1 to v2" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="drop login_attempt_tmp_qwerty" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create user auth table" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="create index IDX_user_auth_auth_module_auth_id - v1" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="alter user_auth.auth_id to length 190" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add OAuth access token to user_auth" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add OAuth refresh token to user_auth" mainflux-grafana | t=2021-08-16T00:55:33+0000 lvl=info msg="Executing migration" logger=migrator id="Add OAuth token type to user_auth" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="Add OAuth expiry to user_auth" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="Add index to user_id column in user_auth" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="create server_lock table" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add index server_lock.operation_uid" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="create user auth token table" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index user_auth_token.auth_token" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index user_auth_token.prev_auth_token" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add index user_auth_token.user_id" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="create cache_data table" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add unique index cache_data.cache_key" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="create short_url table v1" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Executing migration" logger=migrator id="add index short_url.org_id-uid" mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Created default admin" logger=sqlstore user=admin mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Starting plugin search" logger=plugins mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="Registering plugin" logger=plugins id=input mainflux-grafana | t=2021-08-16T00:55:34+0000 lvl=info msg="HTTP Server Listen" logger=http.server address=[::]:3000 protocol=http subUrl= socket= mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.472+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1629075334:472589][1:0x7f459362dac0], txn-recover: [WT_VERB_RECOVERY | WT_VERB_RECOVERY_PROGRESS] Set global recovery timestamp: (0, 0)"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.472+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1629075334:472701][1:0x7f459362dac0], txn-recover: [WT_VERB_RECOVERY | WT_VERB_RECOVERY_PROGRESS] Set global oldest timestamp: (0, 0)"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.477+00:00"},"s":"I", "c":"STORAGE", "id":4795906, "ctx":"initandlisten","msg":"WiredTiger opened","attr":{"durationMillis":705}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.477+00:00"},"s":"I", "c":"RECOVERY", "id":23987, "ctx":"initandlisten","msg":"WiredTiger recoveryTimestamp","attr":{"recoveryTimestamp":{"$timestamp":{"t":0,"i":0}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.509+00:00"},"s":"I", "c":"STORAGE", "id":4366408, "ctx":"initandlisten","msg":"No table logging settings modifications are required for existing WiredTiger tables","attr":{"loggingEnabled":true}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.525+00:00"},"s":"I", "c":"STORAGE", "id":22262, "ctx":"initandlisten","msg":"Timestamp monitor starting"} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.536+00:00"},"s":"W", "c":"CONTROL", "id":22120, "ctx":"initandlisten","msg":"Access control is not enabled for the database. Read and write access to data and configuration is unrestricted","tags":["startupWarnings"]} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.606+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"admin.system.version","uuidDisposition":"provided","uuid":{"uuid":{"$uuid":"637b14d6-a48f-48c4-af25-99284674680a"}},"options":{"uuid":{"$uuid":"637b14d6-a48f-48c4-af25-99284674680a"}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.615+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"admin.system.version","index":"id","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.616+00:00"},"s":"I", "c":"COMMAND", "id":20459, "ctx":"initandlisten","msg":"Setting featureCompatibilityVersion","attr":{"newVersion":"4.4"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.634+00:00"},"s":"I", "c":"STORAGE", "id":20536, "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.660+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"initandlisten","msg":"createCollection","attr":{"namespace":"local.startup_log","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"113f1587-8191-419b-b856-4ba5b41d42c0"}},"options":{"capped":true,"size":10485760}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.666+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"initandlisten","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"local.startup_log","index":"id","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.668+00:00"},"s":"I", "c":"FTDC", "id":20625, "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/data/db/diagnostic.data"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.670+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"/tmp/mongodb-27018.sock"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.670+00:00"},"s":"I", "c":"NETWORK", "id":23015, "ctx":"listener","msg":"Listening on","attr":{"address":"0.0.0.0"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.670+00:00"},"s":"I", "c":"NETWORK", "id":23016, "ctx":"listener","msg":"Waiting for connections","attr":{"port":27018,"ssl":"off"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.751+00:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"LogicalSessionCacheRefresh","msg":"createCollection","attr":{"namespace":"config.system.sessions","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"c9f033cb-41f9-4c0e-a511-fd2c69c89386"}},"options":{}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.751+00:00"},"s":"I", "c":"CONTROL", "id":20712, "ctx":"LogicalSessionCacheReap","msg":"Sessions collection is not set up; waiting until next sessions reap interval","attr":{"error":"NamespaceNotFound: config.system.sessions does not exist"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.759+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.system.sessions","index":"id","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:34.759+00:00"},"s":"I", "c":"INDEX", "id":20345, "ctx":"LogicalSessionCacheRefresh","msg":"Index build: done building","attr":{"buildUUID":null,"namespace":"config.system.sessions","index":"lsidTTLIndex","commitTimestamp":{"$timestamp":{"t":0,"i":0}}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:41.082+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.18.0.25:55872","connectionId":1,"connectionCount":1}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:41.100+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn1","msg":"client metadata","attr":{"remote":"172.18.0.25:55872","client":"conn1","doc":{"driver":{"name":"mongo-go-driver","version":"v1.6.0+prerelease"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.14.4"}}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:41.106+00:00"},"s":"I", "c":"NETWORK", "id":22943, "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.18.0.25:55874","connectionId":2,"connectionCount":2}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:55:41.106+00:00"},"s":"I", "c":"NETWORK", "id":51800, "ctx":"conn2","msg":"client metadata","attr":{"remote":"172.18.0.25:55874","client":"conn2","doc":{"driver":{"name":"mongo-go-driver","version":"v1.6.0+prerelease"},"os":{"type":"linux","architecture":"amd64"},"platform":"go1.14.4"}}} mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:01 +0000] "GET / HTTP/1.1" 200 2417 "-" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:01 +0000] "GET /assets/env.js HTTP/1.1" 200 160 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:01 +0000] "GET /runtime-es2015.888a7406e0ded577c696.js HTTP/1.1" 200 2314 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:01 +0000] "GET /polyfills-es2015.1eaaee95e6c04efcc7ec.js HTTP/1.1" 200 115571 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:01 +0000] "GET /scripts.eb45de723c2271b812ef.js HTTP/1.1" 200 655429 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:02 +0000] "GET /main-es2015.ec95e2debc3a980c2fc4.js HTTP/1.1" 200 1277800 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:02 +0000] "GET /styles.e328b5873eaec8bfedc0.css HTTP/1.1" 200 1827956 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:56:34.533+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"WTCheckpointThread","msg":"WiredTiger message","attr":{"message":"[1629075394:533958][1:0x7f4586119700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 34, snapshot max: 34 snapshot count: 0, oldest timestamp: (0, 0) , meta checkpoint timestamp: (0, 0)"}} mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:45 +0000] "GET /favicon.ico HTTP/1.1" 200 15086 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:46 +0000] "GET /5-es2015.f103ca26e4471a03ce2c.js HTTP/1.1" 200 839044 "http://192.168.1.194:3000/" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:47 +0000] "GET /users/profile HTTP/1.1" 200 2417 "http://192.168.1.194:3000/pages/home" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:56:47 +0000] "GET /version HTTP/1.1" 200 2417 "http://192.168.1.194:3000/pages/home" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:57:00 +0000] "POST /tokens HTTP/1.1" 405 174 "http://192.168.1.194:3000/auth/login" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-ui | 192.168.1.30 - - [16/Aug/2021:00:57:04 +0000] "POST /tokens HTTP/1.1" 405 174 "http://192.168.1.194:3000/auth/login" "Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:91.0) Gecko/20100101 Firefox/91.0" "-" mainflux-twins-db | {"t":{"$date":"2021-08-16T00:57:34.541+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"WTCheckpointThread","msg":"WiredTiger message","attr":{"message":"[1629075454:541506][1:0x7f4586119700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 36, snapshot max: 36 snapshot count: 0, oldest timestamp: (0, 0) , meta checkpoint timestamp: (0, 0)"}} mainflux-twins-db | {"t":{"$date":"2021-08-16T00:58:34.549+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"WTCheckpointThread","msg":"WiredTiger message","attr":{"message":"[1629075514:549473][1:0x7f4586119700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 37, snapshot max: 37 snapshot count: 0, oldest timestamp: (0, 0) , meta checkpoint timestamp: (0, 0)"}}

图片

Thanks,

manuio commented 3 years ago

@iot-lorawan Try to login without port, i.e http://localhost. The port 3000 is for internal use only. It's explained here: https://github.com/mainflux/ui#install

iot-lorawan commented 3 years ago

Hi manuio, Thanks for your kindly help, now it work well as follow your suggestion.

图片

Best Regards,