[05:00:06.917] New invocation is queued and will start shortly
[05:00:08.372] Starting the invocation (attempt 1)
[05:00:08.400] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/49a93a07799aa740340030e3b48ea07c1e951c54"
[05:00:08.400] Popped gitiles commit info from properties and tags
[05:00:08.400] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:08.400] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:08.401] Buildbucket request:
{
"requestId": "8886513634170477856",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8886513634170477856",
"job": "dart/vm-gcc-linux",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "fa4d761f07361830bf6d6705762342b07e821e64"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@fa4d761f07361830bf6d6705762342b07e821e64",
"title": "fa4d761f07361830bf6d6705762342b07e821e64",
"url": "https://dart.googlesource.com/sdk/+/fa4d761f07361830bf6d6705762342b07e821e64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ae5a55bca03b9dab082c7986d4644bf34e8c71ad"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ae5a55bca03b9dab082c7986d4644bf34e8c71ad",
"title": "ae5a55bca03b9dab082c7986d4644bf34e8c71ad",
"url": "https://dart.googlesource.com/sdk/+/ae5a55bca03b9dab082c7986d4644bf34e8c71ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4c8aedcb57fe678e6d30acfdc021aa9888576638"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4c8aedcb57fe678e6d30acfdc021aa9888576638",
"title": "4c8aedcb57fe678e6d30acfdc021aa9888576638",
"url": "https://dart.googlesource.com/sdk/+/4c8aedcb57fe678e6d30acfdc021aa9888576638"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4159ea78e6b110c373256364343d2d8e419fcd86"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4159ea78e6b110c373256364343d2d8e419fcd86",
"title": "4159ea78e6b110c373256364343d2d8e419fcd86",
"url": "https://dart.googlesource.com/sdk/+/4159ea78e6b110c373256364343d2d8e419fcd86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1a79ae68892eeaea676afcf9367235a16b9c790e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1a79ae68892eeaea676afcf9367235a16b9c790e",
"title": "1a79ae68892eeaea676afcf9367235a16b9c790e",
"url": "https://dart.googlesource.com/sdk/+/1a79ae68892eeaea676afcf9367235a16b9c790e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3767d20e56d2a82b50f7cf9518d8fc3bd13e0887"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3767d20e56d2a82b50f7cf9518d8fc3bd13e0887",
"title": "3767d20e56d2a82b50f7cf9518d8fc3bd13e0887",
"url": "https://dart.googlesource.com/sdk/+/3767d20e56d2a82b50f7cf9518d8fc3bd13e0887"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4bd9df1e2b1c11fdf2459f8e9117169d971f845e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4bd9df1e2b1c11fdf2459f8e9117169d971f845e",
"title": "4bd9df1e2b1c11fdf2459f8e9117169d971f845e",
"url": "https://dart.googlesource.com/sdk/+/4bd9df1e2b1c11fdf2459f8e9117169d971f845e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c066e292abfa1a9e13061499ad556fb835a0f571"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c066e292abfa1a9e13061499ad556fb835a0f571",
"title": "c066e292abfa1a9e13061499ad556fb835a0f571",
"url": "https://dart.googlesource.com/sdk/+/c066e292abfa1a9e13061499ad556fb835a0f571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "50ff1c349ca3e029822ce05e54efd46335d6da5e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@50ff1c349ca3e029822ce05e54efd46335d6da5e",
"title": "50ff1c349ca3e029822ce05e54efd46335d6da5e",
"url": "https://dart.googlesource.com/sdk/+/50ff1c349ca3e029822ce05e54efd46335d6da5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b222933af6aadfd89f585569c3b086d6ccbced99"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b222933af6aadfd89f585569c3b086d6ccbced99",
"title": "b222933af6aadfd89f585569c3b086d6ccbced99",
"url": "https://dart.googlesource.com/sdk/+/b222933af6aadfd89f585569c3b086d6ccbced99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5883289bb5776f9b615cb14340236d42bb735608"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5883289bb5776f9b615cb14340236d42bb735608",
"title": "5883289bb5776f9b615cb14340236d42bb735608",
"url": "https://dart.googlesource.com/sdk/+/5883289bb5776f9b615cb14340236d42bb735608"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "76be1bcded5870c7891041902a5930e8a14b1828"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@76be1bcded5870c7891041902a5930e8a14b1828",
"title": "76be1bcded5870c7891041902a5930e8a14b1828",
"url": "https://dart.googlesource.com/sdk/+/76be1bcded5870c7891041902a5930e8a14b1828"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e52b1416609208b058ae3bfca9e8b5496a2ae54b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e52b1416609208b058ae3bfca9e8b5496a2ae54b",
"title": "e52b1416609208b058ae3bfca9e8b5496a2ae54b",
"url": "https://dart.googlesource.com/sdk/+/e52b1416609208b058ae3bfca9e8b5496a2ae54b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6a7fd7cedb6e6aa4d0548f59071ac381f66bc340"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6a7fd7cedb6e6aa4d0548f59071ac381f66bc340",
"title": "6a7fd7cedb6e6aa4d0548f59071ac381f66bc340",
"url": "https://dart.googlesource.com/sdk/+/6a7fd7cedb6e6aa4d0548f59071ac381f66bc340"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e03657855cb27015be8e0a7417310660b08d115c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e03657855cb27015be8e0a7417310660b08d115c",
"title": "e03657855cb27015be8e0a7417310660b08d115c",
"url": "https://dart.googlesource.com/sdk/+/e03657855cb27015be8e0a7417310660b08d115c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "91de656811ea8728792fac3c4afd5ca34bf5f985"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@91de656811ea8728792fac3c4afd5ca34bf5f985",
"title": "91de656811ea8728792fac3c4afd5ca34bf5f985",
"url": "https://dart.googlesource.com/sdk/+/91de656811ea8728792fac3c4afd5ca34bf5f985"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "79ab37f4cd4fbd55d9039f0c96e02e72f61019bc"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@79ab37f4cd4fbd55d9039f0c96e02e72f61019bc",
"title": "79ab37f4cd4fbd55d9039f0c96e02e72f61019bc",
"url": "https://dart.googlesource.com/sdk/+/79ab37f4cd4fbd55d9039f0c96e02e72f61019bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b1849f5fccd1f53601bc0b0b8f1501cc5338a1c1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b1849f5fccd1f53601bc0b0b8f1501cc5338a1c1",
"title": "b1849f5fccd1f53601bc0b0b8f1501cc5338a1c1",
"url": "https://dart.googlesource.com/sdk/+/b1849f5fccd1f53601bc0b0b8f1501cc5338a1c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "49a93a07799aa740340030e3b48ea07c1e951c54"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@49a93a07799aa740340030e3b48ea07c1e951c54",
"title": "49a93a07799aa740340030e3b48ea07c1e951c54",
"url": "https://dart.googlesource.com/sdk/+/49a93a07799aa740340030e3b48ea07c1e951c54"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "49a93a07799aa740340030e3b48ea07c1e951c54",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8886513634170477856"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-gcc-linux"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:00:08.962] Scheduled build:
{
"id": "8721083571883362993",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 589,
"createdBy": "project:dart",
"createTime": "2025-03-07T05:00:08.470480618Z",
"updateTime": "2025-03-07T05:00:08.470480618Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "49a93a07799aa740340030e3b48ea07c1e951c54",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:00:08.962] Task URL: https://cr-buildbucket.appspot.com/build/8721083571883362993
[05:00:08.962] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:2:0) after 7m26s
[05:00:11.550] Received PubSub notification, asking Buildbucket for the build status
[05:00:11.611] Build status: SCHEDULED
[05:00:23.202] Received PubSub notification, asking Buildbucket for the build status
[05:00:23.228] Build status: STARTED
[05:07:34.983] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:2:0)
[05:07:35.000] Build status: STARTED
[05:07:35.000] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:5:0) after 7m43s
[05:15:18.073] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:5:0)
[05:15:18.100] Build status: STARTED
[05:15:18.100] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:6:0) after 9m6s
[05:24:24.387] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:6:0)
[05:24:24.448] Build status: STARTED
[05:24:24.448] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:7:0) after 6m46s
[05:31:10.468] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:7:0)
[05:31:10.493] Build status: STARTED
[05:31:10.493] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:8:0) after 7m23s
[05:38:33.709] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:8:0)
[05:38:33.731] Build status: STARTED
[05:38:33.731] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:9:0) after 9m47s
[05:48:22.379] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:9:0)
[05:48:22.396] Build status: STARTED
[05:48:22.396] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:10:0) after 1m24s
[05:49:46.471] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:10:0)
[05:49:46.490] Build status: STARTED
[05:49:46.490] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:11:0) after 4m9s
[05:53:55.567] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:11:0)
[05:53:55.599] Build status: STARTED
[05:53:55.599] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:12:0) after 6m41s
[06:00:36.718] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:12:0)
[06:00:36.733] Build status: STARTED
[06:00:36.733] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:13:0) after 3m13s
[06:03:49.747] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:13:0)
[06:03:49.765] Build status: STARTED
[06:03:49.765] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:14:0) after 4m17s
[06:08:06.893] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:14:0)
[06:08:06.943] Build status: STARTED
[06:08:06.943] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:15:0) after 9m51s
[06:17:58.411] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:15:0)
[06:17:58.428] Build status: STARTED
[06:17:58.428] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:16:0) after 9m17s
[06:27:15.482] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:16:0)
[06:27:15.497] Build status: STARTED
[06:27:15.497] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:17:0) after 1m20s
[06:28:35.525] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:17:0)
[06:28:35.593] Build status: STARTED
[06:28:35.593] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:18:0) after 5m25s
[06:34:00.618] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:18:0)
[06:34:00.631] Build status: STARTED
[06:34:00.631] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:19:0) after 3m12s
[06:37:12.655] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:19:0)
[06:37:12.673] Build status: STARTED
[06:37:12.673] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:20:0) after 1m45s
[06:38:57.689] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:20:0)
[06:38:57.710] Build status: STARTED
[06:38:57.710] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:21:0) after 8m1s
[06:46:58.737] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:21:0)
[06:46:58.755] Build status: STARTED
[06:46:58.755] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:22:0) after 8m27s
[06:55:25.780] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:22:0)
[06:55:25.801] Build status: STARTED
[06:55:25.801] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:23:0) after 8m44s
[07:04:09.836] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:23:0)
[07:04:09.861] Build status: STARTED
[07:04:09.861] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:24:0) after 9m5s
[07:13:14.861] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:24:0)
[07:13:14.935] Build status: STARTED
[07:13:14.935] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:25:0) after 6m20s
[07:19:34.964] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:25:0)
[07:19:34.987] Build status: STARTED
[07:19:34.987] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:26:0) after 8m54s
[07:28:29.004] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:26:0)
[07:28:29.027] Build status: STARTED
[07:28:29.027] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:27:0) after 3m28s
[07:31:57.054] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:27:0)
[07:31:57.074] Build status: STARTED
[07:31:57.074] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:28:0) after 9m46s
[07:41:43.098] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:28:0)
[07:41:43.119] Build status: STARTED
[07:41:43.119] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:29:0) after 6m53s
[07:48:36.188] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:29:0)
[07:48:36.205] Build status: STARTED
[07:48:36.205] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:30:0) after 5m44s
[07:54:20.293] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:30:0)
[07:54:20.314] Build status: STARTED
[07:54:20.314] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8886513634170477856:31:0) after 8m1s
[07:57:32.985] Received PubSub notification, asking Buildbucket for the build status
[07:57:33.004] Build:
{
"id": "8721083571883362993",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 589,
"createdBy": "project:dart",
"createTime": "2025-03-07T05:00:08.470480618Z",
"startTime": "2025-03-07T05:00:21.889145089Z",
"endTime": "2025-03-07T07:57:30.520121834Z",
"updateTime": "2025-03-07T07:57:30.520121834Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "49a93a07799aa740340030e3b48ea07c1e951c54",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:57:33.004] Invocation finished in 2h57m26.098518688s with status SUCCEEDED