[05:00:29.622] New invocation is queued and will start shortly
[05:00:31.243] Starting the invocation (attempt 1)
[05:00:31.278] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9"
[05:00:31.278] Popped gitiles commit info from properties and tags
[05:00:31.278] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:31.278] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:31.279] Buildbucket request:
{
"requestId": "8892130622280455776",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892130622280455776",
"job": "dart/vm-gcc-linux",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "88f8f3ecda93b77dc5a0fa1afff296ce20387cfb"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@88f8f3ecda93b77dc5a0fa1afff296ce20387cfb",
"title": "88f8f3ecda93b77dc5a0fa1afff296ce20387cfb",
"url": "https://dart.googlesource.com/sdk/+/88f8f3ecda93b77dc5a0fa1afff296ce20387cfb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2d2390469460acaba2fa368dd3c9f141dedef50c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2d2390469460acaba2fa368dd3c9f141dedef50c",
"title": "2d2390469460acaba2fa368dd3c9f141dedef50c",
"url": "https://dart.googlesource.com/sdk/+/2d2390469460acaba2fa368dd3c9f141dedef50c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c02b3a4ea8ba95cdc7f90ac7226a967ec9c3d371"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c02b3a4ea8ba95cdc7f90ac7226a967ec9c3d371",
"title": "c02b3a4ea8ba95cdc7f90ac7226a967ec9c3d371",
"url": "https://dart.googlesource.com/sdk/+/c02b3a4ea8ba95cdc7f90ac7226a967ec9c3d371"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "fe9c469a3da32745a72b31e754b4415a6376776e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@fe9c469a3da32745a72b31e754b4415a6376776e",
"title": "fe9c469a3da32745a72b31e754b4415a6376776e",
"url": "https://dart.googlesource.com/sdk/+/fe9c469a3da32745a72b31e754b4415a6376776e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7041cda56d006ed1d75b7dc65354823a1768cb48"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7041cda56d006ed1d75b7dc65354823a1768cb48",
"title": "7041cda56d006ed1d75b7dc65354823a1768cb48",
"url": "https://dart.googlesource.com/sdk/+/7041cda56d006ed1d75b7dc65354823a1768cb48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "04de77134ed2768c428387fd6c49a688f3d66a9c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@04de77134ed2768c428387fd6c49a688f3d66a9c",
"title": "04de77134ed2768c428387fd6c49a688f3d66a9c",
"url": "https://dart.googlesource.com/sdk/+/04de77134ed2768c428387fd6c49a688f3d66a9c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "9d040aaea9467f8649a2aa1530ab54dae8ed1143"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@9d040aaea9467f8649a2aa1530ab54dae8ed1143",
"title": "9d040aaea9467f8649a2aa1530ab54dae8ed1143",
"url": "https://dart.googlesource.com/sdk/+/9d040aaea9467f8649a2aa1530ab54dae8ed1143"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8b9428b3207c811ab518271fea9ab5c84e7c8af1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8b9428b3207c811ab518271fea9ab5c84e7c8af1",
"title": "8b9428b3207c811ab518271fea9ab5c84e7c8af1",
"url": "https://dart.googlesource.com/sdk/+/8b9428b3207c811ab518271fea9ab5c84e7c8af1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0e880e80841d85a68a1530e35ac5b4c36c6e8707"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0e880e80841d85a68a1530e35ac5b4c36c6e8707",
"title": "0e880e80841d85a68a1530e35ac5b4c36c6e8707",
"url": "https://dart.googlesource.com/sdk/+/0e880e80841d85a68a1530e35ac5b4c36c6e8707"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3b7eb266a327dce1426fe48123702c9933b395a1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3b7eb266a327dce1426fe48123702c9933b395a1",
"title": "3b7eb266a327dce1426fe48123702c9933b395a1",
"url": "https://dart.googlesource.com/sdk/+/3b7eb266a327dce1426fe48123702c9933b395a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "178de40b69ae34bbad12e9a44b37b19080982b59"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@178de40b69ae34bbad12e9a44b37b19080982b59",
"title": "178de40b69ae34bbad12e9a44b37b19080982b59",
"url": "https://dart.googlesource.com/sdk/+/178de40b69ae34bbad12e9a44b37b19080982b59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "29fe663917ee6a5e27e05fa7e8bdf77490abed35"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@29fe663917ee6a5e27e05fa7e8bdf77490abed35",
"title": "29fe663917ee6a5e27e05fa7e8bdf77490abed35",
"url": "https://dart.googlesource.com/sdk/+/29fe663917ee6a5e27e05fa7e8bdf77490abed35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d284a8d046d5db0f6babba7f5798bca6a975f54e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d284a8d046d5db0f6babba7f5798bca6a975f54e",
"title": "d284a8d046d5db0f6babba7f5798bca6a975f54e",
"url": "https://dart.googlesource.com/sdk/+/d284a8d046d5db0f6babba7f5798bca6a975f54e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "499a34afdbc22471166dc6a045787bac803d9ded"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@499a34afdbc22471166dc6a045787bac803d9ded",
"title": "499a34afdbc22471166dc6a045787bac803d9ded",
"url": "https://dart.googlesource.com/sdk/+/499a34afdbc22471166dc6a045787bac803d9ded"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9",
"title": "d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9",
"url": "https://dart.googlesource.com/sdk/+/d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892130622280455776"
},
{
"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:31.794] Scheduled build:
{
"id": "8726700559817218401",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 532,
"createdBy": "project:dart",
"createTime": "2025-01-04T05:00:31.342939981Z",
"updateTime": "2025-01-04T05:00:31.342939981Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:00:31.794] Task URL: https://cr-buildbucket.appspot.com/build/8726700559817218401
[05:00:31.794] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:2:0) after 5m33s
[05:00:32.197] Received PubSub notification, asking Buildbucket for the build status
[05:00:32.235] Build status: SCHEDULED
[05:06:04.814] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:2:0)
[05:06:04.896] Build status: SCHEDULED
[05:06:04.896] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:4:0) after 7m5s
[05:13:09.921] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:4:0)
[05:13:09.967] Build status: SCHEDULED
[05:13:09.967] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:5:0) after 2m43s
[05:15:52.984] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:5:0)
[05:15:53.010] Build status: SCHEDULED
[05:15:53.010] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:6:0) after 9m51s
[05:25:44.033] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:6:0)
[05:25:44.049] Build status: SCHEDULED
[05:25:44.049] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:7:0) after 8m21s
[05:31:38.687] Received PubSub notification, asking Buildbucket for the build status
[05:31:38.710] Build status: STARTED
[05:34:05.102] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:7:0)
[05:34:05.317] Build status: STARTED
[05:34:05.317] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:9:0) after 7m5s
[05:41:10.337] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:9:0)
[05:41:10.379] Build status: STARTED
[05:41:10.379] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:10:0) after 4m29s
[05:45:39.400] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:10:0)
[05:45:39.449] Build status: STARTED
[05:45:39.449] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:11:0) after 7m42s
[05:53:21.562] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:11:0)
[05:53:21.582] Build status: STARTED
[05:53:21.582] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:12:0) after 4m54s
[05:58:15.932] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:12:0)
[05:58:16.012] Build status: STARTED
[05:58:16.012] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:13:0) after 3m2s
[06:01:18.028] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:13:0)
[06:01:18.055] Build status: STARTED
[06:01:18.055] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:14:0) after 3m14s
[06:04:32.078] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:14:0)
[06:04:32.107] Build status: STARTED
[06:04:32.107] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:15:0) after 8m22s
[06:12:54.132] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:15:0)
[06:12:54.184] Build status: STARTED
[06:12:54.184] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:16:0) after 9m3s
[06:21:57.391] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:16:0)
[06:21:57.413] Build status: STARTED
[06:21:57.413] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:17:0) after 6m46s
[06:28:43.490] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:17:0)
[06:28:43.508] Build status: STARTED
[06:28:43.508] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:18:0) after 9m8s
[06:37:51.528] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:18:0)
[06:37:51.553] Build status: STARTED
[06:37:51.553] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:19:0) after 3m34s
[06:41:25.669] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:19:0)
[06:41:25.769] Build status: STARTED
[06:41:25.769] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:20:0) after 3m10s
[06:44:35.807] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:20:0)
[06:44:35.828] Build status: STARTED
[06:44:35.829] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:21:0) after 6m36s
[06:51:12.042] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:21:0)
[06:51:12.064] Build status: STARTED
[06:51:12.064] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:22:0) after 8m43s
[06:59:55.090] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:22:0)
[06:59:55.106] Build status: STARTED
[06:59:55.106] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:23:0) after 4m48s
[07:04:43.221] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:23:0)
[07:04:43.242] Build status: STARTED
[07:04:43.242] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:24:0) after 4m53s
[07:09:36.482] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:24:0)
[07:09:36.534] Build status: STARTED
[07:09:36.534] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:25:0) after 2m59s
[07:12:35.845] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:25:0)
[07:12:35.890] Build status: STARTED
[07:12:35.890] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:26:0) after 7m7s
[07:19:42.912] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:26:0)
[07:19:42.938] Build status: STARTED
[07:19:42.938] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:27:0) after 5m7s
[07:24:50.112] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:27:0)
[07:24:50.131] Build status: STARTED
[07:24:50.131] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:28:0) after 6m13s
[07:31:03.443] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:28:0)
[07:31:03.461] Build status: STARTED
[07:31:03.461] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:29:0) after 9m47s
[07:40:50.483] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:29:0)
[07:40:50.500] Build status: STARTED
[07:40:50.500] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:30:0) after 5m38s
[07:46:28.640] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:30:0)
[07:46:28.656] Build status: STARTED
[07:46:28.656] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8892130622280455776:31:0) after 7m43s
[07:51:43.007] Received PubSub notification, asking Buildbucket for the build status
[07:51:43.031] Build:
{
"id": "8726700559817218401",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 532,
"createdBy": "project:dart",
"createTime": "2025-01-04T05:00:31.342939981Z",
"startTime": "2025-01-04T05:31:30.471632187Z",
"endTime": "2025-01-04T07:51:42.805891240Z",
"updateTime": "2025-01-04T07:51:42.805891240Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "d5a860e8f70a28ba9a63339b5173fc5ca5ec85c9",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:51:43.031] Invocation finished in 2h51m13.421825711s with status SUCCEEDED