2025-06-16T15:01:54.0854998Z === �[31mFAIL�[0m: coderd/provisionerdserver TestAcquireJob_LongPoll (0.45s)
2025-06-16T15:01:54.0855546Z     t.go:106: 2025-06-16 14:59:58.519 [debu]  pubsub: pubsub dialing postgres  network=tcp  address=127.0.0.1:5432  timeout_ms=0
2025-06-16T15:01:54.0856264Z     t.go:106: 2025-06-16 14:59:58.519 [debu]  pubsub: pubsub postgres TCP connection established  network=tcp  address=127.0.0.1:5432  timeout_ms=0  elapsed_ms=0
2025-06-16T15:01:54.0856818Z     t.go:106: 2025-06-16 14:59:58.534 [debu]  pubsub: pubsub connected to postgres
2025-06-16T15:01:54.0857191Z     t.go:106: 2025-06-16 14:59:58.534 [debu]  pubsub: pubsub has started
2025-06-16T15:01:54.0857673Z     t.go:106: 2025-06-16 14:59:58.616 [debu]  pubsub: started listening to event channel  event=provisioner_job_posted
2025-06-16T15:01:54.0858131Z     t.go:106: 2025-06-16 14:59:58.616 [debu]  acquirer: subscribed to job postings
2025-06-16T15:01:54.0858894Z     t.go:106: 2025-06-16 14:59:58.616 [debu]  acquirer: acquiring job  organization_id=e4e87846-6688-42e0-b7a5-d1563e5f7bb1  worker_id=d28e7d18-7aae-4f93-a244-28e84bb15580  provisioner_types=[echo]  tags={}
2025-06-16T15:01:54.0860150Z     t.go:106: 2025-06-16 14:59:58.616 [debu]  acquirer: got clearance to call database  organization_id=e4e87846-6688-42e0-b7a5-d1563e5f7bb1  worker_id=d28e7d18-7aae-4f93-a244-28e84bb15580  provisioner_types=[echo]  tags={}
2025-06-16T15:01:54.0861464Z     t.go:106: 2025-06-16 14:59:58.625 [warn]  acquirer: error attempting to acquire job  organization_id=e4e87846-6688-42e0-b7a5-d1563e5f7bb1  worker_id=d28e7d18-7aae-4f93-a244-28e84bb15580  provisioner_types=[echo]  tags={}  error="pq: canceling statement due to user request"
2025-06-16T15:01:54.0862239Z     provisionerdserver_test.go:75: 
2025-06-16T15:01:54.0862804Z         	Error Trace:	/home/runner/work/coder/coder/coderd/provisionerdserver/provisionerdserver_test.go:75
2025-06-16T15:01:54.0863251Z         	Error:      	Received unexpected error:
2025-06-16T15:01:54.0863554Z         	            	acquire job:
2025-06-16T15:01:54.0864230Z         	            	    github.com/coder/coder/v2/coderd/provisionerdserver.(*server).AcquireJob
2025-06-16T15:01:54.0865173Z         	            	        /home/runner/work/coder/coder/coderd/provisionerdserver/provisionerdserver.go:329
2025-06-16T15:01:54.0865683Z         	            	  - failed to acquire job:
2025-06-16T15:01:54.0866374Z         	            	    github.com/coder/coder/v2/coderd/provisionerdserver.(*Acquirer).AcquireJob
2025-06-16T15:01:54.0867262Z         	            	        /home/runner/work/coder/coder/coderd/provisionerdserver/acquirer.go:148
2025-06-16T15:01:54.0867819Z         	            	  - pq: canceling statement due to user request
2025-06-16T15:01:54.0868127Z         	Test:       	TestAcquireJob_LongPoll
2025-06-16T15:01:54.0868452Z     t.go:106: 2025-06-16 14:59:58.627 [info]  pubsub: pubsub is closing
2025-06-16T15:01:54.0868872Z     t.go:106: 2025-06-16 14:59:58.628 [debu]  pubsub: removing queueSet  event=provisioner_job_posted
2025-06-16T15:01:54.0869401Z     t.go:106: 2025-06-16 14:59:58.628 [debu]  pubsub: stopped listening to event channel  event=provisioner_job_posted
2025-06-16T15:01:54.0869974Z     t.go:106: 2025-06-16 14:59:58.628 [info]  pubsub: pubsub listen