[01:27:38.185] New invocation is queued and will start shortly
[01:27:39.351] Starting the invocation (attempt 1)
[01:27:39.394] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/b4640c359f997e48ab3275688a5d9d3413a9b6af"
[01:27:39.394] Popped gitiles commit info from properties and tags
[01:27:39.395] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:27:39.395] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:27:39.395] Buildbucket request:
{
"requestId": "8956286666308668928",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-frontend"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956286666308668928",
"job": "dart/flutter-frontend",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5b1e6ca6c6287580b925ce0c4ac727d9e5fded38"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5b1e6ca6c6287580b925ce0c4ac727d9e5fded38",
"title": "5b1e6ca6c6287580b925ce0c4ac727d9e5fded38",
"url": "https://dart.googlesource.com/sdk/+/5b1e6ca6c6287580b925ce0c4ac727d9e5fded38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f48a1fb3daf8d2ff33d4ad23efce746580a36884"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f48a1fb3daf8d2ff33d4ad23efce746580a36884",
"title": "f48a1fb3daf8d2ff33d4ad23efce746580a36884",
"url": "https://dart.googlesource.com/sdk/+/f48a1fb3daf8d2ff33d4ad23efce746580a36884"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d56b9b3988e74fe4e3b4a0adfa6ed2cc79caddf4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d56b9b3988e74fe4e3b4a0adfa6ed2cc79caddf4",
"title": "d56b9b3988e74fe4e3b4a0adfa6ed2cc79caddf4",
"url": "https://dart.googlesource.com/sdk/+/d56b9b3988e74fe4e3b4a0adfa6ed2cc79caddf4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3b57bac701df26b943a3e262c9eb44a0574edaff"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3b57bac701df26b943a3e262c9eb44a0574edaff",
"title": "3b57bac701df26b943a3e262c9eb44a0574edaff",
"url": "https://dart.googlesource.com/sdk/+/3b57bac701df26b943a3e262c9eb44a0574edaff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f9fb896455f320e81d41a2d71d81b62a4c8c504d"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f9fb896455f320e81d41a2d71d81b62a4c8c504d",
"title": "f9fb896455f320e81d41a2d71d81b62a4c8c504d",
"url": "https://dart.googlesource.com/sdk/+/f9fb896455f320e81d41a2d71d81b62a4c8c504d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "18c9f52aafeca8cdcb039415572fe3474a7d4430"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@18c9f52aafeca8cdcb039415572fe3474a7d4430",
"title": "18c9f52aafeca8cdcb039415572fe3474a7d4430",
"url": "https://dart.googlesource.com/sdk/+/18c9f52aafeca8cdcb039415572fe3474a7d4430"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a4e4761339990700f44a18b20c06dfdee8ef34d1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a4e4761339990700f44a18b20c06dfdee8ef34d1",
"title": "a4e4761339990700f44a18b20c06dfdee8ef34d1",
"url": "https://dart.googlesource.com/sdk/+/a4e4761339990700f44a18b20c06dfdee8ef34d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "97dc119d4bf5ba509e9fac15e52f44c3a1ecccb2"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@97dc119d4bf5ba509e9fac15e52f44c3a1ecccb2",
"title": "97dc119d4bf5ba509e9fac15e52f44c3a1ecccb2",
"url": "https://dart.googlesource.com/sdk/+/97dc119d4bf5ba509e9fac15e52f44c3a1ecccb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "29b39f5e9ce10ad8633a5c35053dc416322304b0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@29b39f5e9ce10ad8633a5c35053dc416322304b0",
"title": "29b39f5e9ce10ad8633a5c35053dc416322304b0",
"url": "https://dart.googlesource.com/sdk/+/29b39f5e9ce10ad8633a5c35053dc416322304b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e6df56399fcb8cf666d3e1e3566ed0c9cc066735"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e6df56399fcb8cf666d3e1e3566ed0c9cc066735",
"title": "e6df56399fcb8cf666d3e1e3566ed0c9cc066735",
"url": "https://dart.googlesource.com/sdk/+/e6df56399fcb8cf666d3e1e3566ed0c9cc066735"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7b9470edbf7b7a403a63357f0a2640192be976e5"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7b9470edbf7b7a403a63357f0a2640192be976e5",
"title": "7b9470edbf7b7a403a63357f0a2640192be976e5",
"url": "https://dart.googlesource.com/sdk/+/7b9470edbf7b7a403a63357f0a2640192be976e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "9944232752fe8b30ad879eebbe18e8f24f90084d"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@9944232752fe8b30ad879eebbe18e8f24f90084d",
"title": "9944232752fe8b30ad879eebbe18e8f24f90084d",
"url": "https://dart.googlesource.com/sdk/+/9944232752fe8b30ad879eebbe18e8f24f90084d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "fa8c14a3e3c7d788502c06316eb91eb3ef93cda1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@fa8c14a3e3c7d788502c06316eb91eb3ef93cda1",
"title": "fa8c14a3e3c7d788502c06316eb91eb3ef93cda1",
"url": "https://dart.googlesource.com/sdk/+/fa8c14a3e3c7d788502c06316eb91eb3ef93cda1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5cbd424bdfedde8626f55d38d94163b34faffa50"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5cbd424bdfedde8626f55d38d94163b34faffa50",
"title": "5cbd424bdfedde8626f55d38d94163b34faffa50",
"url": "https://dart.googlesource.com/sdk/+/5cbd424bdfedde8626f55d38d94163b34faffa50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "bb63927fed8b9f3f5cf005055d2f703236824c5b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@bb63927fed8b9f3f5cf005055d2f703236824c5b",
"title": "bb63927fed8b9f3f5cf005055d2f703236824c5b",
"url": "https://dart.googlesource.com/sdk/+/bb63927fed8b9f3f5cf005055d2f703236824c5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b4640c359f997e48ab3275688a5d9d3413a9b6af"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b4640c359f997e48ab3275688a5d9d3413a9b6af",
"title": "b4640c359f997e48ab3275688a5d9d3413a9b6af",
"url": "https://dart.googlesource.com/sdk/+/b4640c359f997e48ab3275688a5d9d3413a9b6af"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b4640c359f997e48ab3275688a5d9d3413a9b6af",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956286666308668928"
},
{
"key": "scheduler_job_id",
"value": "dart/flutter-frontend"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:27:39.817] Scheduled build:
{
"id": "8790856604297624241",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-frontend"
},
"number": 15389,
"createdBy": "project:dart",
"createTime": "2023-01-27T01:27:39.479205795Z",
"updateTime": "2023-01-27T01:27:39.479205795Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b4640c359f997e48ab3275688a5d9d3413a9b6af",
"ref": "refs/heads/main"
}
}
}
[01:27:39.817] Task URL: https://cr-buildbucket.appspot.com/build/8790856604297624241
[01:27:39.817] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:2:0) after 5m55s
[01:33:34.853] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:2:0)
[01:33:34.894] Build status: SCHEDULED
[01:33:34.894] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:3:0) after 4m22s
[01:37:56.923] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:3:0)
[01:37:56.953] Build status: SCHEDULED
[01:37:56.953] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:4:0) after 4m1s
[01:41:58.164] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:4:0)
[01:41:58.190] Build status: SCHEDULED
[01:41:58.190] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:5:0) after 1m49s
[01:43:47.288] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:5:0)
[01:43:47.320] Build status: SCHEDULED
[01:43:47.320] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:6:0) after 2m30s
[01:46:17.480] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:6:0)
[01:46:17.589] Build status: SCHEDULED
[01:46:17.589] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:7:0) after 1m50s
[01:48:07.667] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:7:0)
[01:48:07.694] Build status: SCHEDULED
[01:48:07.694] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:8:0) after 6m11s
[01:54:18.713] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:8:0)
[01:54:18.755] Build status: SCHEDULED
[01:54:18.755] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:9:0) after 3m9s
[01:57:27.977] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:9:0)
[01:57:28.001] Build status: SCHEDULED
[01:57:28.001] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:10:0) after 5m9s
[02:02:37.483] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:10:0)
[02:02:37.688] Build status: SCHEDULED
[02:02:37.688] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:11:0) after 2m55s
[02:05:32.719] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:11:0)
[02:05:32.743] Build status: SCHEDULED
[02:05:32.743] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:12:0) after 7m50s
[02:13:22.959] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:12:0)
[02:13:22.983] Build status: SCHEDULED
[02:13:22.983] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:13:0) after 1m16s
[02:14:39.277] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:13:0)
[02:14:39.398] Build status: SCHEDULED
[02:14:39.398] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:14:0) after 7m29s
[02:22:08.601] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:14:0)
[02:22:08.716] Build status: SCHEDULED
[02:22:08.716] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:15:0) after 1m29s
[02:23:37.771] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:15:0)
[02:23:37.797] Build status: SCHEDULED
[02:23:37.797] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:16:0) after 6m43s
[02:30:21.167] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:16:0)
[02:30:21.189] Build status: SCHEDULED
[02:30:21.189] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:17:0) after 1m32s
[02:31:53.531] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:17:0)
[02:31:53.556] Build status: SCHEDULED
[02:31:53.556] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:18:0) after 8m8s
[02:40:01.999] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:18:0)
[02:40:02.025] Build status: SCHEDULED
[02:40:02.025] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:19:0) after 1m32s
[02:41:34.760] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:19:0)
[02:41:34.780] Build status: SCHEDULED
[02:41:34.780] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:20:0) after 8m30s
[02:50:04.772] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:20:0)
[02:50:04.796] Build status: SCHEDULED
[02:50:04.796] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:21:0) after 5m58s
[02:56:02.823] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:21:0)
[02:56:02.851] Build status: SCHEDULED
[02:56:02.851] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:22:0) after 3m13s
[02:59:16.166] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:22:0)
[02:59:16.196] Build status: SCHEDULED
[02:59:16.196] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:23:0) after 6m2s
[03:03:43.052] Received PubSub notification, asking Buildbucket for the build status
[03:03:43.114] Build status: STARTED
[03:05:18.498] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:23:0)
[03:05:18.526] Build status: STARTED
[03:05:18.526] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:25:0) after 7m11s
[03:12:29.675] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:25:0)
[03:12:29.698] Build status: STARTED
[03:12:29.698] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:26:0) after 4m33s
[03:17:02.839] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:26:0)
[03:17:02.863] Build status: STARTED
[03:17:02.863] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:27:0) after 4m58s
[03:22:00.999] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:27:0)
[03:22:01.061] Build status: STARTED
[03:22:01.061] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:28:0) after 7m53s
[03:29:54.271] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:28:0)
[03:29:54.292] Build status: STARTED
[03:29:54.293] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:29:0) after 2m6s
[03:32:00.479] Handling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:29:0)
[03:32:00.588] Build status: STARTED
[03:32:00.588] Scheduling timer "check-buildbucket-build-status" (dart/flutter-frontend:8956286666308668928:30:0) after 7m13s
[03:35:27.459] Received PubSub notification, asking Buildbucket for the build status
[03:35:27.483] Build:
{
"id": "8790856604297624241",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-frontend"
},
"number": 15389,
"createdBy": "project:dart",
"createTime": "2023-01-27T01:27:39.479205795Z",
"startTime": "2023-01-27T03:03:42.441629Z",
"endTime": "2023-01-27T03:35:26.929970362Z",
"updateTime": "2023-01-27T03:35:26.929970362Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b4640c359f997e48ab3275688a5d9d3413a9b6af",
"ref": "refs/heads/main"
}
}
}
[03:35:27.483] Invocation finished in 2h7m49.306583456s with status SUCCEEDED