[05:00:06.102] New invocation is queued and will start shortly
[05:00:07.232] Starting the invocation (attempt 1)
[05:00:07.270] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/7e8f84b57101cbee4d1cb39af16301d32a3ca466"
[05:00:07.270] Popped gitiles commit info from properties and tags
[05:00:07.270] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:07.270] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:07.271] Buildbucket request:
{
"requestId": "8882074383667087136",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882074383667087136",
"job": "dart/vm-msvc-windows",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "9282dc5b067b6e0365382690b3dd2a8b678cfc00"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@9282dc5b067b6e0365382690b3dd2a8b678cfc00",
"title": "9282dc5b067b6e0365382690b3dd2a8b678cfc00",
"url": "https://dart.googlesource.com/sdk/+/9282dc5b067b6e0365382690b3dd2a8b678cfc00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0049e288072f097f3e76f96638d14dcf97a54aa9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0049e288072f097f3e76f96638d14dcf97a54aa9",
"title": "0049e288072f097f3e76f96638d14dcf97a54aa9",
"url": "https://dart.googlesource.com/sdk/+/0049e288072f097f3e76f96638d14dcf97a54aa9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5e6f501da57a557b34e6e4bac465b5c628a1ecea"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5e6f501da57a557b34e6e4bac465b5c628a1ecea",
"title": "5e6f501da57a557b34e6e4bac465b5c628a1ecea",
"url": "https://dart.googlesource.com/sdk/+/5e6f501da57a557b34e6e4bac465b5c628a1ecea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "55dc02c2b1d0209535e1036be3bd831fe0d072dd"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@55dc02c2b1d0209535e1036be3bd831fe0d072dd",
"title": "55dc02c2b1d0209535e1036be3bd831fe0d072dd",
"url": "https://dart.googlesource.com/sdk/+/55dc02c2b1d0209535e1036be3bd831fe0d072dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "db448306dcb86700f6c519070924a741e9b5a20c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@db448306dcb86700f6c519070924a741e9b5a20c",
"title": "db448306dcb86700f6c519070924a741e9b5a20c",
"url": "https://dart.googlesource.com/sdk/+/db448306dcb86700f6c519070924a741e9b5a20c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a30330466e53416f956471c93e7c5fd0080b8834"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a30330466e53416f956471c93e7c5fd0080b8834",
"title": "a30330466e53416f956471c93e7c5fd0080b8834",
"url": "https://dart.googlesource.com/sdk/+/a30330466e53416f956471c93e7c5fd0080b8834"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f75a80392efa9aa1cf7916b5d0b58441453f94c5"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f75a80392efa9aa1cf7916b5d0b58441453f94c5",
"title": "f75a80392efa9aa1cf7916b5d0b58441453f94c5",
"url": "https://dart.googlesource.com/sdk/+/f75a80392efa9aa1cf7916b5d0b58441453f94c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e81bc24cfb798b758620b34ab0f305652e6d597a"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e81bc24cfb798b758620b34ab0f305652e6d597a",
"title": "e81bc24cfb798b758620b34ab0f305652e6d597a",
"url": "https://dart.googlesource.com/sdk/+/e81bc24cfb798b758620b34ab0f305652e6d597a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1a6755cbf4b0c46a4f944f25861495bde37f9fca"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1a6755cbf4b0c46a4f944f25861495bde37f9fca",
"title": "1a6755cbf4b0c46a4f944f25861495bde37f9fca",
"url": "https://dart.googlesource.com/sdk/+/1a6755cbf4b0c46a4f944f25861495bde37f9fca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c5dc2921964ea49dd69a4478cd1533008001de89"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c5dc2921964ea49dd69a4478cd1533008001de89",
"title": "c5dc2921964ea49dd69a4478cd1533008001de89",
"url": "https://dart.googlesource.com/sdk/+/c5dc2921964ea49dd69a4478cd1533008001de89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "876118deec3418df8622beb140e64067ce5bd056"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@876118deec3418df8622beb140e64067ce5bd056",
"title": "876118deec3418df8622beb140e64067ce5bd056",
"url": "https://dart.googlesource.com/sdk/+/876118deec3418df8622beb140e64067ce5bd056"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "feaa0c6aa752c89edb1014a1bd9ecc46ef08d1ab"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@feaa0c6aa752c89edb1014a1bd9ecc46ef08d1ab",
"title": "feaa0c6aa752c89edb1014a1bd9ecc46ef08d1ab",
"url": "https://dart.googlesource.com/sdk/+/feaa0c6aa752c89edb1014a1bd9ecc46ef08d1ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f7ff419cd36da46855b22fdfbad557b7385ef61b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f7ff419cd36da46855b22fdfbad557b7385ef61b",
"title": "f7ff419cd36da46855b22fdfbad557b7385ef61b",
"url": "https://dart.googlesource.com/sdk/+/f7ff419cd36da46855b22fdfbad557b7385ef61b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "85227c449265527783b077a55696da202168a5b8"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@85227c449265527783b077a55696da202168a5b8",
"title": "85227c449265527783b077a55696da202168a5b8",
"url": "https://dart.googlesource.com/sdk/+/85227c449265527783b077a55696da202168a5b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "509e1038cc2375bdad1968c777cba1225221eddd"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@509e1038cc2375bdad1968c777cba1225221eddd",
"title": "509e1038cc2375bdad1968c777cba1225221eddd",
"url": "https://dart.googlesource.com/sdk/+/509e1038cc2375bdad1968c777cba1225221eddd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "05017208900cec3262dc05b95aea1c5196bc1a4b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@05017208900cec3262dc05b95aea1c5196bc1a4b",
"title": "05017208900cec3262dc05b95aea1c5196bc1a4b",
"url": "https://dart.googlesource.com/sdk/+/05017208900cec3262dc05b95aea1c5196bc1a4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "807074b1e8b1729dc7ed044df87f64778ac30c34"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@807074b1e8b1729dc7ed044df87f64778ac30c34",
"title": "807074b1e8b1729dc7ed044df87f64778ac30c34",
"url": "https://dart.googlesource.com/sdk/+/807074b1e8b1729dc7ed044df87f64778ac30c34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "16d65943461964bd663e78072792bd0da21d567c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@16d65943461964bd663e78072792bd0da21d567c",
"title": "16d65943461964bd663e78072792bd0da21d567c",
"url": "https://dart.googlesource.com/sdk/+/16d65943461964bd663e78072792bd0da21d567c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4ddb83ea9bf93abfa8a12f77517c2f2a62607636"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4ddb83ea9bf93abfa8a12f77517c2f2a62607636",
"title": "4ddb83ea9bf93abfa8a12f77517c2f2a62607636",
"url": "https://dart.googlesource.com/sdk/+/4ddb83ea9bf93abfa8a12f77517c2f2a62607636"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8fb9578d95d0ffa55b190ac82dd411412fb566dc"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8fb9578d95d0ffa55b190ac82dd411412fb566dc",
"title": "8fb9578d95d0ffa55b190ac82dd411412fb566dc",
"url": "https://dart.googlesource.com/sdk/+/8fb9578d95d0ffa55b190ac82dd411412fb566dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1dd93dd0bbeb30431f343eb9f890731535159e0a"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1dd93dd0bbeb30431f343eb9f890731535159e0a",
"title": "1dd93dd0bbeb30431f343eb9f890731535159e0a",
"url": "https://dart.googlesource.com/sdk/+/1dd93dd0bbeb30431f343eb9f890731535159e0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "26641af3a132aa058b66f7b0da19ffd2a5875b5e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@26641af3a132aa058b66f7b0da19ffd2a5875b5e",
"title": "26641af3a132aa058b66f7b0da19ffd2a5875b5e",
"url": "https://dart.googlesource.com/sdk/+/26641af3a132aa058b66f7b0da19ffd2a5875b5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7e8f84b57101cbee4d1cb39af16301d32a3ca466"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7e8f84b57101cbee4d1cb39af16301d32a3ca466",
"title": "7e8f84b57101cbee4d1cb39af16301d32a3ca466",
"url": "https://dart.googlesource.com/sdk/+/7e8f84b57101cbee4d1cb39af16301d32a3ca466"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "7e8f84b57101cbee4d1cb39af16301d32a3ca466",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882074383667087136"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-msvc-windows"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:00:07.821] Scheduled build:
{
"id": "8716644321708848929",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 640,
"createdBy": "project:dart",
"createTime": "2025-04-25T05:00:07.345461851Z",
"updateTime": "2025-04-25T05:00:07.345461851Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "7e8f84b57101cbee4d1cb39af16301d32a3ca466",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:00:07.821] Task URL: https://cr-buildbucket.appspot.com/build/8716644321708848929
[05:00:07.821] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:2:0) after 9m26s
[05:00:11.813] Received PubSub notification, asking Buildbucket for the build status
[05:00:11.841] Build status: SCHEDULED
[05:00:14.874] Received PubSub notification, asking Buildbucket for the build status
[05:00:14.896] Build status: STARTED
[05:09:34.308] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:2:0)
[05:09:34.330] Build status: STARTED
[05:09:34.331] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:5:0) after 2m8s
[05:11:42.355] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:5:0)
[05:11:42.401] Build status: STARTED
[05:11:42.401] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:6:0) after 4m2s
[05:15:44.913] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:6:0)
[05:15:44.939] Build status: STARTED
[05:15:44.939] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:7:0) after 1m45s
[05:17:30.030] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:7:0)
[05:17:30.048] Build status: STARTED
[05:17:30.048] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:8:0) after 6m14s
[05:23:44.124] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:8:0)
[05:23:44.601] Build status: STARTED
[05:23:44.601] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:9:0) after 3m29s
[05:27:14.014] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:9:0)
[05:27:14.035] Build status: STARTED
[05:27:14.035] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:10:0) after 9m27s
[05:36:41.288] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:10:0)
[05:36:41.334] Build status: STARTED
[05:36:41.334] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:11:0) after 4m22s
[05:41:03.519] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:11:0)
[05:41:03.545] Build status: STARTED
[05:41:03.545] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:12:0) after 9m49s
[05:50:52.644] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:12:0)
[05:50:52.688] Build status: STARTED
[05:50:52.688] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:13:0) after 2m4s
[05:52:57.130] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:13:0)
[05:52:57.154] Build status: STARTED
[05:52:57.154] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:14:0) after 3m37s
[05:56:34.200] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:14:0)
[05:56:34.224] Build status: STARTED
[05:56:34.224] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:15:0) after 1m14s
[05:57:48.725] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:15:0)
[05:57:48.756] Build status: STARTED
[05:57:48.756] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:16:0) after 8m57s
[06:06:45.772] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:16:0)
[06:06:45.806] Build status: STARTED
[06:06:45.806] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:17:0) after 8m6s
[06:14:51.853] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:17:0)
[06:14:51.880] Build status: STARTED
[06:14:51.880] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:18:0) after 3m0s
[06:17:51.902] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:18:0)
[06:17:51.965] Build status: STARTED
[06:17:51.966] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:19:0) after 6m52s
[06:24:44.022] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:19:0)
[06:24:44.036] Build status: STARTED
[06:24:44.036] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:20:0) after 8m35s
[06:33:19.095] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:20:0)
[06:33:19.111] Build status: STARTED
[06:33:19.111] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:21:0) after 7m4s
[06:40:23.153] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:21:0)
[06:40:23.235] Build status: STARTED
[06:40:23.235] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:22:0) after 6m12s
[06:46:35.252] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:22:0)
[06:46:35.295] Build status: STARTED
[06:46:35.295] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:23:0) after 5m18s
[06:51:53.635] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:23:0)
[06:51:53.653] Build status: STARTED
[06:51:53.653] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:24:0) after 4m16s
[06:56:09.680] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:24:0)
[06:56:09.713] Build status: STARTED
[06:56:09.713] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8882074383667087136:25:0) after 1m19s
[06:56:22.887] Received PubSub notification, asking Buildbucket for the build status
[06:56:22.904] Build:
{
"id": "8716644321708848929",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 640,
"createdBy": "project:dart",
"createTime": "2025-04-25T05:00:07.345461851Z",
"startTime": "2025-04-25T05:00:13.215814198Z",
"endTime": "2025-04-25T06:56:22.588609862Z",
"updateTime": "2025-04-25T06:56:22.588609862Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "7e8f84b57101cbee4d1cb39af16301d32a3ca466",
"ref": "refs/heads/main"
}
},
"canary": true
}
[06:56:22.904] Invocation finished in 1h56m16.810411264s with status SUCCEEDED