You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
flow.go:220: Running step: mysql-sidecar-dockerDefault
time="2024-06-19T08:33:14.198685873Z" level=info msg="Watching directories: [components/docker/default]" instance=fv-az1789-634 scope=dapr.runtime.hotreload.loader.disk type=log ver=unknown
dapr client initializing for: 127.0.0.1:38567
time="2024-06-19T08:33:14.198959757Z" level=info msg="metrics server started on :0/" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.198964292Z" level=info msg="standalone mode configured" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.199122895Z" level=info msg="app id: mysql-sidecar-dockerDefault" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.199197094Z" level=info msg="Dapr trace sampler initialized: ParentBased***root:TraceIDRatioBased***0.0001***,remoteParentSampled:AlwaysOnSampler,remoteParentNotSampled:AlwaysOffSampler,localParentSampled:AlwaysOnSampler,localParentNotSampled:AlwaysOffSampler***" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.199483287Z" level=info msg="local service entry announced: mysql-sidecar-dockerDefault -> 10.1.0.206:33385" component="nr (mdns/v1)" instance=fv-az1789-634 scope=dapr.contrib type=log ver=unknown
time="2024-06-19T08:33:14.199508714Z" level=info msg="Initialized name resolution to mdns" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.199577973Z" level=info msg="Loading components…" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.202668051Z" level=info msg="Creating MySql state table 'state'" instance=fv-az1789-634 scope=dapr.components type=log ver=unknown
time="2024-06-19T08:33:14.208472995Z" level=info msg="Creating MySQL metadata table" instance=fv-az1789-634 scope=dapr.components type=log ver=unknown
time="2024-06-19T08:33:14.211057671Z" level=info msg="Component loaded: mariadb (state.mysql/v1)" instance=fv-az1789-634 scope=dapr.runtime.processor type=log ver=unknown
time="2024-06-19T08:33:14.211107742Z" level=info msg="Schedule expired data clean up every 1h0m0s" instance=fv-az1789-634 scope=dapr.components type=log ver=unknown
time="2024-06-19T08:33:14.211188913Z" level=info msg="Waiting for all outstanding components to be processed…" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.211243757Z" level=error msg="dial tcp 127.0.0.1:3306: connect: connection refused" instance=fv-az1789-634 scope=dapr.components type=log ver=unknown
time="2024-06-19T08:33:14.211290033Z" level=error msg="Failed to init component mysql (state.mysql/v1): [INIT_COMPONENT_FAILURE]: initialization error occurred for mysql (state.mysql/v1): dial tcp 127.0.0.1:3306: connect: connection refused" instance=fv-az1789-634 scope=dapr.runtime.processor type=log ver=unknown
time="2024-06-19T08:33:14.211317915Z" level=warning msg="Error processing component, daprd will exit gracefully" instance=fv-az1789-634 scope=dapr.runtime.processor type=log ver=unknown
time="2024-06-19T08:33:14.211345246Z" level=info msg="All outstanding components processed" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.211362659Z" level=info msg="Loading endpoints…" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.211732027Z" level=info msg="Waiting for all outstanding http endpoints to be processed…" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.211748557Z" level=info msg="All outstanding http endpoints processed" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.211758266Z" level=info msg="Loading Declarative Subscriptions…" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212150286Z" level=warning msg="App channel is not initialized. Did you configure an app-port?" instance=fv-az1789-634 scope=dapr.runtime.channels type=log ver=unknown
time="2024-06-19T08:33:14.212257315Z" level=info msg="gRPC server listening on TCP address: 127.0.0.1:38567" instance=fv-az1789-634 scope=dapr.runtime.grpc.api type=log ver=unknown
time="2024-06-19T08:33:14.212273055Z" level=info msg="Enabled gRPC tracing middleware" instance=fv-az1789-634 scope=dapr.runtime.grpc.api type=log ver=unknown
time="2024-06-19T08:33:14.212280619Z" level=info msg="Enabled gRPC metrics middleware" instance=fv-az1789-634 scope=dapr.runtime.grpc.api type=log ver=unknown
time="2024-06-19T08:33:14.212341342Z" level=info msg="Registering workflow engine for gRPC endpoint: 127.0.0.1:38567" instance=fv-az1789-634 scope=dapr.runtime.grpc.api type=log ver=unknown
time="2024-06-19T08:33:14.2123835Z" level=info msg="API gRPC server is running on port 38567" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212430207Z" level=info msg="Enabled max body size HTTP middleware with size 4194304 bytes" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.212446508Z" level=info msg="Enabled tracing HTTP middleware" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.212455625Z" level=info msg="Enabled metrics HTTP middleware" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.212669433Z" level=info msg="HTTP server listening on TCP address: 127.0.0.1:3500" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.212708736Z" level=info msg="HTTP profiling server listening on: 127.0.0.1:7777" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.2127324[81](https://github.com/dapr/components-contrib/actions/runs/9578740452/job/26409659072#step:19:82)Z" level=info msg="HTTP server is running on port 3500" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212741417Z" level=info msg="The request body size parameter is: 4194304 bytes" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212773738Z" level=info msg="gRPC server listening on TCP address: :33385" instance=fv-az1789-634 scope=dapr.runtime.grpc.internal type=log ver=unknown
time="2024-06-19T08:33:14.212786431Z" level=info msg="Enabled gRPC tracing middleware" instance=fv-az1789-634 scope=dapr.runtime.grpc.internal type=log ver=unknown
time="2024-06-19T08:33:14.212794075Z" level=info msg="Enabled gRPC metrics middleware" instance=fv-az1789-634 scope=dapr.runtime.grpc.internal type=log ver=unknown
time="2024-06-19T08:33:14.212819412Z" level=info msg="Internal gRPC server is running on port 333[85](https://github.com/dapr/components-contrib/actions/runs/9578740452/job/26409659072#step:19:86)" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212878523Z" level=info msg="Configuring workflow engine with actors backend" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212894252Z" level=info msg="No workflow registry available, not registering Dapr workflow component." instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212906505Z" level=warning msg="failed to read from bindings: app channel not initialized " instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212916954Z" level=info msg="dapr initialized. Status: Running. Init Elapsed 13ms" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.212946803Z" level=info msg="Shutting down workflow engine" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.2129[87](https://github.com/dapr/components-contrib/actions/runs/9578740452/job/26409659072#step:19:88)559Z" level=info msg="Dapr is shutting down" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.21299508Z" level=info msg="Closing HTTP server …" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
time="2024-06-19T08:33:14.213021653Z" level=info msg="Shutting down component mariadb (state.mysql/v1)" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.213079136Z" level=info msg="stopping mDNS server for app id: mysql-sidecar-dockerDefault" component="nr (mdns/v1)" instance=fv-az17[89](https://github.com/dapr/components-contrib/actions/runs/9578740452/job/26409659072#step:19:90)-634 scope=dapr.contrib type=log ver=unknown
time="2024-06-19T08:33:14.213259937Z" level=info msg="Dapr runtime stopped" instance=fv-az1789-634 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T08:33:14.213073606Z" level=info msg="Closing HTTP server 127.0.0.1:3500…" instance=fv-az1789-634 scope=dapr.runtime.http type=log ver=unknown
flow.go:228: Completed step: mysql-sidecar-dockerDefault
flow.go:230: Fatal error in step mysql-sidecar-dockerDefault: error creating connection to '127.0.0.1:38567': context deadline exceeded
dockercompose.go:72: Stopping db_mariadb_1 ...
Stopping db_mysql_1 ...
Stopping db_mysql_1 ... done
Stopping db_mariadb_1 ... done
Removing db_mariadb_1 ...
Removing db_mysql_1 ...
Removing db_mariadb_1 ... done
Removing db_mysql_1 ... done
Removing network db_default
Running mysql/mariadb docker files:
mysql-1 | 2024-06-20T15:14:43.342995Z 0 [Warning] [MY-010015] [Repl] Gtid table is not ready to be used. Table 'mysql.gtid_executed' cannot be opened.
mysql-1 | 2024-06-20T15:14:43.346688Z 0 [Warning] [MY-010068] [Server] CA certificate ca.pem is self signed.
mysql-1 | 2024-06-20T15:14:43.346720Z 0 [System] [MY-013602] [Server] Channel mysql_main configured to support TLS. Encrypted connections are now supported for this channel.
mysql-1 | 2024-06-20T15:14:43.349537Z 0 [Warning] [MY-011810] [Server] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
mysql-1 | 2024-06-20T15:14:43.350169Z 0 [Warning] [MY-010441] [Server] Failed to open optimizer cost constant tables
mysql-1 | 2024-06-20T15:14:43.350290Z 0 [ERROR] [MY-013129] [Server] A message intended for a client cannot be sent there as no client-session is attached. Therefore, we're sending the information to the error-log instead: MY-001146 - Table 'mysql.component' doesn't exist
mysql-1 | 2024-06-20T15:14:43.350307Z 0 [Warning] [MY-013129] [Server] A message intended for a client cannot be sent there as no client-session is attached. Therefore, we're sending the information to the error-log instead: MY-003543 - The mysql.component table is missing or has an incorrect definition.
mysql-1 | 2024-06-20T15:14:43.350364Z 0 [ERROR] [MY-000067] [Server] unknown variable 'default-authentication-plugin=mysql_native_password'.
mysql-1 | 2024-06-20T15:14:43.350646Z 0 [ERROR] [MY-010119] [Server] Aborting
mysql-1 | 2024-06-20T15:14:44.857403Z 0 [System] [MY-010910] [Server] /usr/sbin/mysqld: Shutdown complete (mysqld 8.4.0) MySQL Community Server - GPL.
mysql-1 | 2024-06-20T15:14:44.857429Z 0 [System] [MY-015016] [Server] MySQL Server - end.
mysql-1 exited with code 0
Appears to be failing due to MySQL 8.4 changes - [https://dev.mysql.com/doc/refman/8.4/en/pluggable-authentication.html](https://dev.mysql.com/doc/refman/8.4/en/pluggable-authentication.html)
// TODO: The following test function will always fail as expected because the sidecar didn't initialize the component (expected). This should be updated to look for a much more specific error signature however by reading the sidecar's stderr.
Running certification tests for bindings.rabbitmq ...
Source Pacakge: github.com/dapr/components-contrib/bindings/rabbitmq
FAIL
exit status 1
FAIL github.com/dapr/components-contrib/tests/certification/bindings/rabbitmq 93.525s
=== Failed
=== FAIL: bindings/rabbitmq TestRabbitMQExclusive/rabbitmq_certification (8.97s)
flow.go:220: Running step: rabbitmqcertification
dockercompose.go:57: Creating network "rabbitmqcertification_rabbitmq_go_net" with driver "bridge"
Creating rabbitmq ...
Creating rabbitmq ... done
flow.go:228: Completed step: rabbitmqcertification
flow.go:220: Running step: wait for rabbitmq readiness
retry.go:33: Failure: Exception (501) Reason: "read tcp [::1]:43450->[::1]:[56](https://github.com/dapr/components-contrib/actions/runs/9585432188/job/26431317352#step:19:57)72: read: connection reset by peer"; Retrying in 1s
retry.go:35: Success!
flow.go:228: Completed step: wait for rabbitmq readiness
flow.go:220: Running step: standardApp
flow.go:228: Completed step: standardApp
flow.go:220: Running step: standardSidecar
time="2024-06-19T16:35:46.840913098Z" level=error msg="[INIT_FAILURE]: initialization error occurred for metrics: runtime/actor/timers: cannot register view \"runtime/actor/timers\"; a different view with the same name is already registered\nruntime/actor/reminders: cannot register view \"runtime/actor/reminders\"; a different view with the same name is already registered" instance=fv-az1020-[67](https://github.com/dapr/components-contrib/actions/runs/9585432188/job/26431317352#step:19:68)1 scope=dapr.runtime type=log ver=unknown
time="2024-06-19T16:35:46.840990072Z" level=info msg="Watching directories: [./components/exclusive]" instance=fv-az1020-671 scope=dapr.runtime.hotreload.loader.disk type=log ver=unknown
flow.go:228: Completed step: standardSidecar
flow.go:230: Fatal error in step standardSidecar: failed to create watcher: failed to add target ./components/exclusive: no such file or directory
dockercompose.go:[72](https://github.com/dapr/components-contrib/actions/runs/9585432188/job/26431317352#step:19:73): Stopping rabbitmq ...
Stopping rabbitmq ... done
Removing rabbitmq ...
Removing rabbitmq ... done
Removing network rabbitmqcertification_rabbitmq_go_net
=== FAIL: bindings/rabbitmq TestRabbitMQExclusive (8.98s)
This is missing a component spec to even run the sidecar.
The sidecar exits after the component setup failure, resulting in messages being sent to the sidecar failing with timeouts.
The last successful scheduled run was 4 months ago on the 7th of Feb.
Consistent failures with:
There are various other flaky tests but they do pass on occasion.
Not in test scope
state.mysql
Originates from:
components-contrib/tests/certification/state/mysql/mysql_test.go
Lines 569 to 575 in a385743
Running mysql/mariadb docker files:
Fix: use
--mysql-native-password=ON
flagbindings.rabbitmq
Failure originates from:
components-contrib/tests/certification/bindings/rabbitmq/rabbitmq_test.go
Lines 506 to 514 in a385743
pubsub.mqtt3
WARNING: Long logs
Tests appear to be timing out primarily
Release Note
RELEASE NOTE:
The text was updated successfully, but these errors were encountered: