[18:25:34.074] New invocation is queued and will start shortly
[18:25:35.153] Starting the invocation (attempt 1)
[18:25:35.182] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/monorepo/+/7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4"
[18:25:35.182] Popped gitiles commit info from properties and tags
[18:25:35.182] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:25:35.182] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:25:35.182] Buildbucket request:
{
"requestId": "8929949503339573616",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-web"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8929949503339573616",
"job": "dart/flutter-web",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "88b735884ba78043c5c2037013a36bd8132d52b6"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@88b735884ba78043c5c2037013a36bd8132d52b6",
"title": "88b735884ba78043c5c2037013a36bd8132d52b6",
"url": "https://dart.googlesource.com/monorepo//+/88b735884ba78043c5c2037013a36bd8132d52b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "a49de7c9ebeafcec3a2187330ade44772bb9e434"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@a49de7c9ebeafcec3a2187330ade44772bb9e434",
"title": "a49de7c9ebeafcec3a2187330ade44772bb9e434",
"url": "https://dart.googlesource.com/monorepo//+/a49de7c9ebeafcec3a2187330ade44772bb9e434"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "843f37fa2358608a433edf0bae82855fe5024741"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@843f37fa2358608a433edf0bae82855fe5024741",
"title": "843f37fa2358608a433edf0bae82855fe5024741",
"url": "https://dart.googlesource.com/monorepo//+/843f37fa2358608a433edf0bae82855fe5024741"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "08ed50f9c5871e88d12c7f34d352ccf41267fa99"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@08ed50f9c5871e88d12c7f34d352ccf41267fa99",
"title": "08ed50f9c5871e88d12c7f34d352ccf41267fa99",
"url": "https://dart.googlesource.com/monorepo//+/08ed50f9c5871e88d12c7f34d352ccf41267fa99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "d09393b7aed5c145d40531e0ee137a4aab7abebf"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@d09393b7aed5c145d40531e0ee137a4aab7abebf",
"title": "d09393b7aed5c145d40531e0ee137a4aab7abebf",
"url": "https://dart.googlesource.com/monorepo//+/d09393b7aed5c145d40531e0ee137a4aab7abebf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "6e80f8d36e3736b0346190d5eabe695bdda56737"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@6e80f8d36e3736b0346190d5eabe695bdda56737",
"title": "6e80f8d36e3736b0346190d5eabe695bdda56737",
"url": "https://dart.googlesource.com/monorepo//+/6e80f8d36e3736b0346190d5eabe695bdda56737"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "b14ee5fe303212bb3fc96d38adc76476741d9400"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@b14ee5fe303212bb3fc96d38adc76476741d9400",
"title": "b14ee5fe303212bb3fc96d38adc76476741d9400",
"url": "https://dart.googlesource.com/monorepo//+/b14ee5fe303212bb3fc96d38adc76476741d9400"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "1d35a42c84d5de5ef0f596659bde6e4c26abfbf3"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@1d35a42c84d5de5ef0f596659bde6e4c26abfbf3",
"title": "1d35a42c84d5de5ef0f596659bde6e4c26abfbf3",
"url": "https://dart.googlesource.com/monorepo//+/1d35a42c84d5de5ef0f596659bde6e4c26abfbf3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4",
"title": "7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4",
"url": "https://dart.googlesource.com/monorepo//+/7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8929949503339573616"
},
{
"key": "scheduler_job_id",
"value": "dart/flutter-web"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:25:35.868] Scheduled build:
{
"id": "8764519441454489697",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-web"
},
"number": 1893,
"createdBy": "project:dart",
"createTime": "2023-11-13T18:25:35.249546784Z",
"updateTime": "2023-11-13T18:25:35.249546784Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4",
"ref": "refs/heads/main"
}
}
}
[18:25:35.868] Task URL: https://cr-buildbucket.appspot.com/build/8764519441454489697
[18:25:35.868] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:2:0) after 4m4s
[18:25:36.852] Received PubSub notification, asking Buildbucket for the build status
[18:25:36.877] Build status: SCHEDULED
[18:29:39.943] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:2:0)
[18:29:39.974] Build status: SCHEDULED
[18:29:39.974] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:4:0) after 4m7s
[18:33:47.030] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:4:0)
[18:33:47.053] Build status: SCHEDULED
[18:33:47.053] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:5:0) after 6m6s
[18:39:53.082] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:5:0)
[18:39:53.137] Build status: SCHEDULED
[18:39:53.137] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:6:0) after 2m6s
[18:41:59.162] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:6:0)
[18:41:59.197] Build status: SCHEDULED
[18:41:59.197] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:7:0) after 5m47s
[18:47:46.263] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:7:0)
[18:47:46.283] Build status: SCHEDULED
[18:47:46.283] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:8:0) after 6m7s
[18:53:53.287] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:8:0)
[18:53:53.307] Build status: SCHEDULED
[18:53:53.307] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:9:0) after 6m31s
[19:00:24.350] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:9:0)
[19:00:24.383] Build status: SCHEDULED
[19:00:24.383] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:10:0) after 7m51s
[19:08:15.510] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:10:0)
[19:08:15.527] Build status: SCHEDULED
[19:08:15.527] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:11:0) after 8m41s
[19:16:56.548] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:11:0)
[19:16:56.641] Build status: SCHEDULED
[19:16:56.641] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:12:0) after 2m30s
[19:19:26.662] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:12:0)
[19:19:26.684] Build status: SCHEDULED
[19:19:26.684] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:13:0) after 6m5s
[19:25:31.739] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:13:0)
[19:25:31.768] Build status: SCHEDULED
[19:25:31.768] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:14:0) after 9m21s
[19:34:52.918] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:14:0)
[19:34:52.968] Build status: SCHEDULED
[19:34:52.968] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:15:0) after 2m3s
[19:36:55.995] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:15:0)
[19:36:56.089] Build status: SCHEDULED
[19:36:56.089] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:16:0) after 2m37s
[19:39:33.187] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:16:0)
[19:39:33.211] Build status: SCHEDULED
[19:39:33.211] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:17:0) after 4m5s
[19:43:38.276] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:17:0)
[19:43:38.319] Build status: SCHEDULED
[19:43:38.320] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:18:0) after 7m42s
[19:43:55.624] Received PubSub notification, asking Buildbucket for the build status
[19:43:55.648] Build status: STARTED
[19:51:20.305] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:18:0)
[19:51:20.331] Build status: STARTED
[19:51:20.331] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:20:0) after 4m4s
[19:55:24.485] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:20:0)
[19:55:24.512] Build status: STARTED
[19:55:24.512] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:21:0) after 4m24s
[19:59:48.502] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:21:0)
[19:59:48.529] Build status: STARTED
[19:59:48.529] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:22:0) after 1m53s
[20:01:41.595] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:22:0)
[20:01:41.616] Build status: STARTED
[20:01:41.616] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:23:0) after 1m24s
[20:03:05.704] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:23:0)
[20:03:05.741] Build status: STARTED
[20:03:05.741] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:24:0) after 6m7s
[20:09:12.757] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:24:0)
[20:09:12.806] Build status: STARTED
[20:09:12.806] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:25:0) after 6m42s
[20:15:54.791] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:25:0)
[20:15:54.810] Build status: STARTED
[20:15:54.810] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:26:0) after 6m4s
[20:21:58.862] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:26:0)
[20:21:58.887] Build status: STARTED
[20:21:58.887] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:27:0) after 1m3s
[20:23:01.906] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:27:0)
[20:23:02.015] Build status: STARTED
[20:23:02.015] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:28:0) after 2m32s
[20:25:34.043] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:28:0)
[20:25:34.066] Build status: STARTED
[20:25:34.066] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:29:0) after 6m27s
[20:32:01.190] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:29:0)
[20:32:01.226] Build status: STARTED
[20:32:01.226] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:30:0) after 7m24s
[20:39:25.268] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:30:0)
[20:39:25.288] Build status: STARTED
[20:39:25.288] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:31:0) after 6m11s
[20:45:36.312] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:31:0)
[20:45:36.337] Build status: STARTED
[20:45:36.337] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:32:0) after 2m46s
[20:48:22.374] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:32:0)
[20:48:22.396] Build status: STARTED
[20:48:22.396] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:33:0) after 6m7s
[20:54:29.384] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:33:0)
[20:54:29.408] Build status: STARTED
[20:54:29.408] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:34:0) after 4m41s
[20:59:10.402] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:34:0)
[20:59:10.469] Build status: STARTED
[20:59:10.469] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:35:0) after 2m44s
[21:01:54.502] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:35:0)
[21:01:54.524] Build status: STARTED
[21:01:54.524] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:36:0) after 3m15s
[21:05:09.606] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:36:0)
[21:05:09.778] Build status: STARTED
[21:05:09.778] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:37:0) after 2m39s
[21:07:48.846] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:37:0)
[21:07:48.875] Build status: STARTED
[21:07:48.875] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:38:0) after 4m10s
[21:11:58.904] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:38:0)
[21:11:58.933] Build status: STARTED
[21:11:58.934] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:39:0) after 9m29s
[21:21:27.954] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:39:0)
[21:21:27.976] Build status: STARTED
[21:21:27.976] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:40:0) after 7m44s
[21:29:12.002] Handling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:40:0)
[21:29:12.095] Build status: STARTED
[21:29:12.095] Scheduling timer "check-buildbucket-build-status" (dart/flutter-web:8929949503339573616:41:0) after 9m42s
[21:36:09.617] Received PubSub notification, asking Buildbucket for the build status
[21:36:09.640] Build:
{
"id": "8764519441454489697",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-web"
},
"number": 1893,
"createdBy": "project:dart",
"createTime": "2023-11-13T18:25:35.249546784Z",
"startTime": "2023-11-13T19:43:55.105147Z",
"endTime": "2023-11-13T21:36:09.056663Z",
"updateTime": "2023-11-13T21:36:09.056663Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "7e2fb437a846ea2e7fd5045278df4ed7f3d5bcf4",
"ref": "refs/heads/main"
}
}
}
[21:36:09.640] Invocation finished in 3h10m35.572696992s with status SUCCEEDED