[17:59:16.921] New invocation is queued and will start shortly
[17:59:18.299] Starting the invocation (attempt 1)
[17:59:18.330] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/2248e04f8d428785e7b4320614ffbfc116e255f9"
[17:59:18.330] Popped gitiles commit info from properties and tags
[17:59:18.330] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:59:18.330] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:59:18.331] Buildbucket request:
{
"requestId": "8957764425788902032",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "analyzer-linux-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8957764425788902032",
"job": "dart/analyzer-linux-release",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c7eb34d6aa8c96d669aed051c476bb50f657dc1f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c7eb34d6aa8c96d669aed051c476bb50f657dc1f",
"title": "c7eb34d6aa8c96d669aed051c476bb50f657dc1f",
"url": "https://dart.googlesource.com/sdk/+/c7eb34d6aa8c96d669aed051c476bb50f657dc1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ab287309e52eff8cb25a6457aae3bc621a410838"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ab287309e52eff8cb25a6457aae3bc621a410838",
"title": "ab287309e52eff8cb25a6457aae3bc621a410838",
"url": "https://dart.googlesource.com/sdk/+/ab287309e52eff8cb25a6457aae3bc621a410838"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2248e04f8d428785e7b4320614ffbfc116e255f9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2248e04f8d428785e7b4320614ffbfc116e255f9",
"title": "2248e04f8d428785e7b4320614ffbfc116e255f9",
"url": "https://dart.googlesource.com/sdk/+/2248e04f8d428785e7b4320614ffbfc116e255f9"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2248e04f8d428785e7b4320614ffbfc116e255f9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8957764425788902032"
},
{
"key": "scheduler_job_id",
"value": "dart/analyzer-linux-release"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:59:18.822] Scheduled build:
{
"id": "8792334363528903409",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "analyzer-linux-release"
},
"number": 19971,
"createdBy": "project:dart",
"createTime": "2023-01-10T17:59:18.454072829Z",
"updateTime": "2023-01-10T17:59:18.454072829Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2248e04f8d428785e7b4320614ffbfc116e255f9",
"ref": "refs/heads/main"
}
}
}
[17:59:18.822] Task URL: https://cr-buildbucket.appspot.com/build/8792334363528903409
[17:59:18.823] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:2:0) after 4m41s
[18:03:59.949] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:2:0)
[18:03:59.974] Build status: SCHEDULED
[18:03:59.974] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:3:0) after 3m54s
[18:07:54.000] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:3:0)
[18:07:54.171] Build status: SCHEDULED
[18:07:54.171] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:4:0) after 2m15s
[18:10:09.261] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:4:0)
[18:10:09.289] Build status: SCHEDULED
[18:10:09.289] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:5:0) after 4m53s
[18:15:02.302] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:5:0)
[18:15:02.332] Build status: SCHEDULED
[18:15:02.332] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:6:0) after 8m0s
[18:23:02.586] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:6:0)
[18:23:02.631] Build status: SCHEDULED
[18:23:02.631] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:7:0) after 3m59s
[18:27:01.680] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:7:0)
[18:27:01.703] Build status: SCHEDULED
[18:27:01.703] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:8:0) after 2m9s
[18:29:10.721] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:8:0)
[18:29:10.764] Build status: SCHEDULED
[18:29:10.764] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:9:0) after 6m47s
[18:35:58.099] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:9:0)
[18:35:58.147] Build status: SCHEDULED
[18:35:58.147] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:10:0) after 6m43s
[18:42:41.793] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:10:0)
[18:42:41.820] Build status: SCHEDULED
[18:42:41.820] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:11:0) after 8m20s
[18:51:01.836] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:11:0)
[18:51:01.870] Build status: SCHEDULED
[18:51:01.870] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:12:0) after 5m49s
[18:56:51.117] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:12:0)
[18:56:51.147] Build status: SCHEDULED
[18:56:51.147] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:13:0) after 4m22s
[19:01:13.263] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:13:0)
[19:01:13.391] Build status: SCHEDULED
[19:01:13.391] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:14:0) after 5m18s
[19:06:31.546] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:14:0)
[19:06:31.575] Build status: SCHEDULED
[19:06:31.575] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:15:0) after 5m5s
[19:11:36.599] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:15:0)
[19:11:36.661] Build status: SCHEDULED
[19:11:36.661] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:16:0) after 6m40s
[19:18:16.677] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:16:0)
[19:18:16.894] Build status: SCHEDULED
[19:18:16.894] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:17:0) after 3m2s
[19:20:17.107] Received PubSub notification, asking Buildbucket for the build status
[19:20:17.133] Build status: STARTED
[19:21:18.965] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:17:0)
[19:21:19.004] Build status: STARTED
[19:21:19.004] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:19:0) after 8m0s
[19:29:19.267] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:19:0)
[19:29:19.291] Build status: STARTED
[19:29:19.291] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:20:0) after 2m40s
[19:31:59.498] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:20:0)
[19:31:59.524] Build status: STARTED
[19:31:59.524] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:21:0) after 7m13s
[19:39:12.549] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:21:0)
[19:39:12.587] Build status: STARTED
[19:39:12.587] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:22:0) after 3m35s
[19:42:47.702] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:22:0)
[19:42:47.730] Build status: STARTED
[19:42:47.730] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:23:0) after 8m45s
[19:51:32.776] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:23:0)
[19:51:32.799] Build status: STARTED
[19:51:32.799] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:24:0) after 2m53s
[19:54:25.820] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:24:0)
[19:54:25.991] Build status: STARTED
[19:54:25.991] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:25:0) after 7m49s
[20:02:15.519] Handling timer "check-buildbucket-build-status" (dart/analyzer-linux-release:8957764425788902032:25:0)
[20:02:15.556] Build:
{
"id": "8792334363528903409",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "analyzer-linux-release"
},
"number": 19971,
"createdBy": "project:dart",
"createTime": "2023-01-10T17:59:18.454072829Z",
"startTime": "2023-01-10T19:20:16.252684Z",
"endTime": "2023-01-10T19:54:34.550199563Z",
"updateTime": "2023-01-10T19:54:34.550199563Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2248e04f8d428785e7b4320614ffbfc116e255f9",
"ref": "refs/heads/main"
}
}
}
[20:02:15.556] Invocation finished in 2h2m58.641140333s with status SUCCEEDED