[05:00:07.298] New invocation is queued and will start shortly
[05:00:09.051] Starting the invocation (attempt 1)
[05:00:09.083] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/2a388bdee406feb6f2b45a38c6286047a28d3fd3"
[05:00:09.083] Popped gitiles commit info from properties and tags
[05:00:09.083] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:09.083] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:09.084] Buildbucket request:
{
"requestId": "8882889755118956464",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882889755118956464",
"job": "dart/vm-gcc-linux",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e4676d5b5690220996191357064c1137e4990a09"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e4676d5b5690220996191357064c1137e4990a09",
"title": "e4676d5b5690220996191357064c1137e4990a09",
"url": "https://dart.googlesource.com/sdk/+/e4676d5b5690220996191357064c1137e4990a09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f24d4d1653119a5fc2eb4c7b2f4f795fb3092bad"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f24d4d1653119a5fc2eb4c7b2f4f795fb3092bad",
"title": "f24d4d1653119a5fc2eb4c7b2f4f795fb3092bad",
"url": "https://dart.googlesource.com/sdk/+/f24d4d1653119a5fc2eb4c7b2f4f795fb3092bad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7427e655f6f502f925d56569e100dbc2347fd43e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7427e655f6f502f925d56569e100dbc2347fd43e",
"title": "7427e655f6f502f925d56569e100dbc2347fd43e",
"url": "https://dart.googlesource.com/sdk/+/7427e655f6f502f925d56569e100dbc2347fd43e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "de32acf9ac02a62e7d3e3a61cef3a7bbb38fa6cb"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@de32acf9ac02a62e7d3e3a61cef3a7bbb38fa6cb",
"title": "de32acf9ac02a62e7d3e3a61cef3a7bbb38fa6cb",
"url": "https://dart.googlesource.com/sdk/+/de32acf9ac02a62e7d3e3a61cef3a7bbb38fa6cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "39152168f1bdfa041537209969650ab4726a55fe"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@39152168f1bdfa041537209969650ab4726a55fe",
"title": "39152168f1bdfa041537209969650ab4726a55fe",
"url": "https://dart.googlesource.com/sdk/+/39152168f1bdfa041537209969650ab4726a55fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3dd7e2273922a24fb46b383c414e7ec63cdba4e9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3dd7e2273922a24fb46b383c414e7ec63cdba4e9",
"title": "3dd7e2273922a24fb46b383c414e7ec63cdba4e9",
"url": "https://dart.googlesource.com/sdk/+/3dd7e2273922a24fb46b383c414e7ec63cdba4e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ef85087008b0c09d3318dceac4ad47e1666966c0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ef85087008b0c09d3318dceac4ad47e1666966c0",
"title": "ef85087008b0c09d3318dceac4ad47e1666966c0",
"url": "https://dart.googlesource.com/sdk/+/ef85087008b0c09d3318dceac4ad47e1666966c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a9dd011f94b3c8ca67cf451dc5c3f831b9339832"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a9dd011f94b3c8ca67cf451dc5c3f831b9339832",
"title": "a9dd011f94b3c8ca67cf451dc5c3f831b9339832",
"url": "https://dart.googlesource.com/sdk/+/a9dd011f94b3c8ca67cf451dc5c3f831b9339832"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8eba93ed6c78f784349917e73354fcdf9f236d37"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8eba93ed6c78f784349917e73354fcdf9f236d37",
"title": "8eba93ed6c78f784349917e73354fcdf9f236d37",
"url": "https://dart.googlesource.com/sdk/+/8eba93ed6c78f784349917e73354fcdf9f236d37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "9a81185627e9e9b4d9e3ee4ec57dde159d968a30"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@9a81185627e9e9b4d9e3ee4ec57dde159d968a30",
"title": "9a81185627e9e9b4d9e3ee4ec57dde159d968a30",
"url": "https://dart.googlesource.com/sdk/+/9a81185627e9e9b4d9e3ee4ec57dde159d968a30"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8fb4afaf8bb76065baea8d70482461782354ce1e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8fb4afaf8bb76065baea8d70482461782354ce1e",
"title": "8fb4afaf8bb76065baea8d70482461782354ce1e",
"url": "https://dart.googlesource.com/sdk/+/8fb4afaf8bb76065baea8d70482461782354ce1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8505c558da004e747f6f0ef5c00ba722891320d6"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8505c558da004e747f6f0ef5c00ba722891320d6",
"title": "8505c558da004e747f6f0ef5c00ba722891320d6",
"url": "https://dart.googlesource.com/sdk/+/8505c558da004e747f6f0ef5c00ba722891320d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "62e7377dfabb30c1374a583d5c2ee3d45e65c0b4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@62e7377dfabb30c1374a583d5c2ee3d45e65c0b4",
"title": "62e7377dfabb30c1374a583d5c2ee3d45e65c0b4",
"url": "https://dart.googlesource.com/sdk/+/62e7377dfabb30c1374a583d5c2ee3d45e65c0b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4f818d498bddedce505a3eb26a50dd39d1656dd2"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4f818d498bddedce505a3eb26a50dd39d1656dd2",
"title": "4f818d498bddedce505a3eb26a50dd39d1656dd2",
"url": "https://dart.googlesource.com/sdk/+/4f818d498bddedce505a3eb26a50dd39d1656dd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1f4fddd023ee9fe2c5565b5606b3f7bb7be6287b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1f4fddd023ee9fe2c5565b5606b3f7bb7be6287b",
"title": "1f4fddd023ee9fe2c5565b5606b3f7bb7be6287b",
"url": "https://dart.googlesource.com/sdk/+/1f4fddd023ee9fe2c5565b5606b3f7bb7be6287b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5ec368622c007bf8f57e475b59faac02586266c0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5ec368622c007bf8f57e475b59faac02586266c0",
"title": "5ec368622c007bf8f57e475b59faac02586266c0",
"url": "https://dart.googlesource.com/sdk/+/5ec368622c007bf8f57e475b59faac02586266c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3ef86d28077c847dea29862666b1e914f91b1605"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3ef86d28077c847dea29862666b1e914f91b1605",
"title": "3ef86d28077c847dea29862666b1e914f91b1605",
"url": "https://dart.googlesource.com/sdk/+/3ef86d28077c847dea29862666b1e914f91b1605"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2a388bdee406feb6f2b45a38c6286047a28d3fd3"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2a388bdee406feb6f2b45a38c6286047a28d3fd3",
"title": "2a388bdee406feb6f2b45a38c6286047a28d3fd3",
"url": "https://dart.googlesource.com/sdk/+/2a388bdee406feb6f2b45a38c6286047a28d3fd3"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2a388bdee406feb6f2b45a38c6286047a28d3fd3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882889755118956464"
},
{
"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:09.559] Scheduled build:
{
"id": "8717459692509802817",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 622,
"createdBy": "project:dart",
"createTime": "2025-04-16T05:00:09.154982349Z",
"updateTime": "2025-04-16T05:00:09.154982349Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2a388bdee406feb6f2b45a38c6286047a28d3fd3",
"ref": "refs/heads/main"
}
}
}
[05:00:09.559] Task URL: https://cr-buildbucket.appspot.com/build/8717459692509802817
[05:00:09.559] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:2:0) after 7m43s
[05:00:10.075] Received PubSub notification, asking Buildbucket for the build status
[05:00:10.156] Build status: SCHEDULED
[05:00:21.659] Received PubSub notification, asking Buildbucket for the build status
[05:00:21.678] Build status: STARTED
[05:07:52.689] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:2:0)
[05:07:52.716] Build status: STARTED
[05:07:52.716] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:5:0) after 8m45s
[05:16:37.772] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:5:0)
[05:16:37.795] Build status: STARTED
[05:16:37.795] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:6:0) after 5m50s
[05:22:27.812] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:6:0)
[05:22:27.888] Build status: STARTED
[05:22:27.889] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:7:0) after 1m22s
[05:23:49.964] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:7:0)
[05:23:49.993] Build status: STARTED
[05:23:49.993] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:8:0) after 1m40s
[05:25:30.139] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:8:0)
[05:25:30.159] Build status: STARTED
[05:25:30.159] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:9:0) after 6m21s
[05:31:51.183] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:9:0)
[05:31:51.213] Build status: STARTED
[05:31:51.213] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:10:0) after 1m22s
[05:33:13.277] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:10:0)
[05:33:13.296] Build status: STARTED
[05:33:13.296] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:11:0) after 6m21s
[05:39:34.314] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:11:0)
[05:39:34.336] Build status: STARTED
[05:39:34.336] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:12:0) after 4m32s
[05:44:06.363] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:12:0)
[05:44:06.382] Build status: STARTED
[05:44:06.382] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:13:0) after 3m19s
[05:47:25.442] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:13:0)
[05:47:25.489] Build status: STARTED
[05:47:25.489] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:14:0) after 6m38s
[05:54:03.508] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:14:0)
[05:54:03.535] Build status: STARTED
[05:54:03.535] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:15:0) after 2m55s
[05:56:58.561] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:15:0)
[05:56:58.586] Build status: STARTED
[05:56:58.586] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:16:0) after 1m41s
[05:58:39.610] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:16:0)
[05:58:39.630] Build status: STARTED
[05:58:39.630] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:17:0) after 5m2s
[06:03:41.655] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:17:0)
[06:03:41.674] Build status: STARTED
[06:03:41.674] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:18:0) after 3m57s
[06:07:38.693] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:18:0)
[06:07:38.712] Build status: STARTED
[06:07:38.712] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:19:0) after 8m55s
[06:16:33.783] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:19:0)
[06:16:33.800] Build status: STARTED
[06:16:33.800] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:20:0) after 8m44s
[06:25:17.825] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:20:0)
[06:25:17.844] Build status: STARTED
[06:25:17.844] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:21:0) after 8m53s
[06:34:11.003] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:21:0)
[06:34:11.074] Build status: STARTED
[06:34:11.074] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:22:0) after 4m42s
[06:38:53.107] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:22:0)
[06:38:53.134] Build status: STARTED
[06:38:53.134] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:23:0) after 1m23s
[06:40:16.202] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:23:0)
[06:40:16.256] Build status: STARTED
[06:40:16.256] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:24:0) after 2m55s
[06:43:11.322] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:24:0)
[06:43:11.342] Build status: STARTED
[06:43:11.342] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:25:0) after 8m28s
[06:51:39.435] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:25:0)
[06:51:39.450] Build status: STARTED
[06:51:39.450] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:26:0) after 7m50s
[06:59:29.451] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:26:0)
[06:59:29.477] Build status: STARTED
[06:59:29.477] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:27:0) after 9m36s
[07:09:05.496] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:27:0)
[07:09:05.522] Build status: STARTED
[07:09:05.522] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:28:0) after 7m1s
[07:16:06.547] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:28:0)
[07:16:06.594] Build status: STARTED
[07:16:06.594] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:29:0) after 6m54s
[07:23:00.637] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:29:0)
[07:23:00.696] Build status: STARTED
[07:23:00.696] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:30:0) after 6m19s
[07:29:19.719] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:30:0)
[07:29:19.738] Build status: STARTED
[07:29:19.738] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:31:0) after 8m8s
[07:37:27.727] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:31:0)
[07:37:27.747] Build status: STARTED
[07:37:27.747] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:32:0) after 1m21s
[07:38:48.825] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:32:0)
[07:38:48.847] Build status: STARTED
[07:38:48.847] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:33:0) after 3m9s
[07:41:57.902] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:33:0)
[07:41:58.004] Build status: STARTED
[07:41:58.004] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:34:0) after 8m22s
[07:50:20.072] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:34:0)
[07:50:20.171] Build status: STARTED
[07:50:20.171] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:35:0) after 1m10s
[07:51:30.195] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:35:0)
[07:51:30.222] Build status: STARTED
[07:51:30.222] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:36:0) after 1m5s
[07:52:35.243] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:36:0)
[07:52:35.260] Build status: STARTED
[07:52:35.260] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:37:0) after 5m53s
[07:58:28.309] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:37:0)
[07:58:28.336] Build status: STARTED
[07:58:28.336] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8882889755118956464:38:0) after 8m47s
[08:03:45.163] Received PubSub notification, asking Buildbucket for the build status
[08:03:45.188] Build:
{
"id": "8717459692509802817",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 622,
"createdBy": "project:dart",
"createTime": "2025-04-16T05:00:09.154982349Z",
"startTime": "2025-04-16T05:00:20.412019825Z",
"endTime": "2025-04-16T08:03:35.110889497Z",
"updateTime": "2025-04-16T08:03:35.110889497Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "2a388bdee406feb6f2b45a38c6286047a28d3fd3",
"ref": "refs/heads/main"
}
}
}
[08:03:45.188] Invocation finished in 3h3m37.905280582s with status SUCCEEDED