[05:00:07.052] New invocation is queued and will start shortly
[05:00:08.683] Starting the invocation (attempt 1)
[05:00:08.717] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/3e09072221b5fe4e8ea3d4fb69f120af8aa499cd"
[05:00:08.717] Popped gitiles commit info from properties and tags
[05:00:08.717] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:08.717] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:08.718] Buildbucket request:
{
"requestId": "8926466896207440368",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8926466896207440368",
"job": "dart/vm-msvc-windows",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a967ead7e9651f9698a39e6fd4d59a1ed8ed45d2"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a967ead7e9651f9698a39e6fd4d59a1ed8ed45d2",
"title": "a967ead7e9651f9698a39e6fd4d59a1ed8ed45d2",
"url": "https://dart.googlesource.com/sdk/+/a967ead7e9651f9698a39e6fd4d59a1ed8ed45d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6ce0504924d4b273ffb5d0a6591769b3cb425890"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6ce0504924d4b273ffb5d0a6591769b3cb425890",
"title": "6ce0504924d4b273ffb5d0a6591769b3cb425890",
"url": "https://dart.googlesource.com/sdk/+/6ce0504924d4b273ffb5d0a6591769b3cb425890"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "562f66b313acbe2206bc78e4fb05354655a2be17"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@562f66b313acbe2206bc78e4fb05354655a2be17",
"title": "562f66b313acbe2206bc78e4fb05354655a2be17",
"url": "https://dart.googlesource.com/sdk/+/562f66b313acbe2206bc78e4fb05354655a2be17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "969de20633796c1ba31cbda7f0697c773fef3af5"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@969de20633796c1ba31cbda7f0697c773fef3af5",
"title": "969de20633796c1ba31cbda7f0697c773fef3af5",
"url": "https://dart.googlesource.com/sdk/+/969de20633796c1ba31cbda7f0697c773fef3af5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7fbe4cc95bd4444b3aa450a69770dceb15d0a15a"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7fbe4cc95bd4444b3aa450a69770dceb15d0a15a",
"title": "7fbe4cc95bd4444b3aa450a69770dceb15d0a15a",
"url": "https://dart.googlesource.com/sdk/+/7fbe4cc95bd4444b3aa450a69770dceb15d0a15a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c2d0ca576d78ba811b4ccbdddc12270e0f1bc582"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c2d0ca576d78ba811b4ccbdddc12270e0f1bc582",
"title": "c2d0ca576d78ba811b4ccbdddc12270e0f1bc582",
"url": "https://dart.googlesource.com/sdk/+/c2d0ca576d78ba811b4ccbdddc12270e0f1bc582"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d2fc240a3e62deb0c6b9da77b304fdc047357e4c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d2fc240a3e62deb0c6b9da77b304fdc047357e4c",
"title": "d2fc240a3e62deb0c6b9da77b304fdc047357e4c",
"url": "https://dart.googlesource.com/sdk/+/d2fc240a3e62deb0c6b9da77b304fdc047357e4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d71d0f873313391f6fb521cb70390b89605468ba"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d71d0f873313391f6fb521cb70390b89605468ba",
"title": "d71d0f873313391f6fb521cb70390b89605468ba",
"url": "https://dart.googlesource.com/sdk/+/d71d0f873313391f6fb521cb70390b89605468ba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6eaec1ec423bd0542fef3fc428c8139d4e162bb7"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6eaec1ec423bd0542fef3fc428c8139d4e162bb7",
"title": "6eaec1ec423bd0542fef3fc428c8139d4e162bb7",
"url": "https://dart.googlesource.com/sdk/+/6eaec1ec423bd0542fef3fc428c8139d4e162bb7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6f9c9b935bb3ae70e5bf6a717dd81f34f4be1621"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6f9c9b935bb3ae70e5bf6a717dd81f34f4be1621",
"title": "6f9c9b935bb3ae70e5bf6a717dd81f34f4be1621",
"url": "https://dart.googlesource.com/sdk/+/6f9c9b935bb3ae70e5bf6a717dd81f34f4be1621"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "49cd3d96570e884c1142dda99958b263b2ba52c0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@49cd3d96570e884c1142dda99958b263b2ba52c0",
"title": "49cd3d96570e884c1142dda99958b263b2ba52c0",
"url": "https://dart.googlesource.com/sdk/+/49cd3d96570e884c1142dda99958b263b2ba52c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "39b44a02f5e13616c78da0fdbb0bc17d04f174a2"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@39b44a02f5e13616c78da0fdbb0bc17d04f174a2",
"title": "39b44a02f5e13616c78da0fdbb0bc17d04f174a2",
"url": "https://dart.googlesource.com/sdk/+/39b44a02f5e13616c78da0fdbb0bc17d04f174a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3b27f54e00a227b0562c1f7a8f1228822a3dc941"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3b27f54e00a227b0562c1f7a8f1228822a3dc941",
"title": "3b27f54e00a227b0562c1f7a8f1228822a3dc941",
"url": "https://dart.googlesource.com/sdk/+/3b27f54e00a227b0562c1f7a8f1228822a3dc941"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b574db44939e3113e6f45c08ee558bc96fe2304f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b574db44939e3113e6f45c08ee558bc96fe2304f",
"title": "b574db44939e3113e6f45c08ee558bc96fe2304f",
"url": "https://dart.googlesource.com/sdk/+/b574db44939e3113e6f45c08ee558bc96fe2304f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4bebe882be49014aea434d07166bd6e1bbc8d3cc"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4bebe882be49014aea434d07166bd6e1bbc8d3cc",
"title": "4bebe882be49014aea434d07166bd6e1bbc8d3cc",
"url": "https://dart.googlesource.com/sdk/+/4bebe882be49014aea434d07166bd6e1bbc8d3cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ecb662c9cdba866d81866e630362571b7a4d3966"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ecb662c9cdba866d81866e630362571b7a4d3966",
"title": "ecb662c9cdba866d81866e630362571b7a4d3966",
"url": "https://dart.googlesource.com/sdk/+/ecb662c9cdba866d81866e630362571b7a4d3966"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "94c8d341d7a8f254de38ea9168533c4c6bae8a49"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@94c8d341d7a8f254de38ea9168533c4c6bae8a49",
"title": "94c8d341d7a8f254de38ea9168533c4c6bae8a49",
"url": "https://dart.googlesource.com/sdk/+/94c8d341d7a8f254de38ea9168533c4c6bae8a49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a0c9333ff32ff2761fd797847bcde3b7ef23dc94"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a0c9333ff32ff2761fd797847bcde3b7ef23dc94",
"title": "a0c9333ff32ff2761fd797847bcde3b7ef23dc94",
"url": "https://dart.googlesource.com/sdk/+/a0c9333ff32ff2761fd797847bcde3b7ef23dc94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3e09072221b5fe4e8ea3d4fb69f120af8aa499cd"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3e09072221b5fe4e8ea3d4fb69f120af8aa499cd",
"title": "3e09072221b5fe4e8ea3d4fb69f120af8aa499cd",
"url": "https://dart.googlesource.com/sdk/+/3e09072221b5fe4e8ea3d4fb69f120af8aa499cd"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "3e09072221b5fe4e8ea3d4fb69f120af8aa499cd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8926466896207440368"
},
{
"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:09.525] Scheduled build:
{
"id": "8761036833642310273",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 224,
"createdBy": "project:dart",
"createTime": "2023-12-22T05:00:08.874061211Z",
"updateTime": "2023-12-22T05:00:08.874061211Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "3e09072221b5fe4e8ea3d4fb69f120af8aa499cd",
"ref": "refs/heads/main"
}
}
}
[05:00:09.525] Task URL: https://cr-buildbucket.appspot.com/build/8761036833642310273
[05:00:09.525] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:2:0) after 5m49s
[05:00:13.018] Received PubSub notification, asking Buildbucket for the build status
[05:00:13.045] Build status: SCHEDULED
[05:00:39.715] Received PubSub notification, asking Buildbucket for the build status
[05:00:39.734] Build status: STARTED
[05:05:58.699] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:2:0)
[05:05:58.717] Build status: STARTED
[05:05:58.717] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:5:0) after 7m25s
[05:13:23.732] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:5:0)
[05:13:23.765] Build status: STARTED
[05:13:23.766] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:6:0) after 5m27s
[05:18:50.806] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:6:0)
[05:18:50.879] Build status: STARTED
[05:18:50.879] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:7:0) after 3m21s
[05:22:11.981] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:7:0)
[05:22:12.042] Build status: STARTED
[05:22:12.042] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:8:0) after 3m49s
[05:26:01.066] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:8:0)
[05:26:01.095] Build status: STARTED
[05:26:01.095] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:9:0) after 6m2s
[05:32:03.114] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:9:0)
[05:32:03.229] Build status: STARTED
[05:32:03.229] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:10:0) after 1m6s
[05:33:09.304] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:10:0)
[05:33:09.336] Build status: STARTED
[05:33:09.336] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:11:0) after 2m45s
[05:35:54.365] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:11:0)
[05:35:54.403] Build status: STARTED
[05:35:54.403] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:12:0) after 4m5s
[05:39:59.703] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:12:0)
[05:39:59.718] Build status: STARTED
[05:39:59.718] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:13:0) after 6m34s
[05:46:33.746] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:13:0)
[05:46:33.766] Build status: STARTED
[05:46:33.766] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:14:0) after 5m3s
[05:51:36.797] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:14:0)
[05:51:36.861] Build status: STARTED
[05:51:36.861] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:15:0) after 4m34s
[05:56:10.882] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:15:0)
[05:56:10.906] Build status: STARTED
[05:56:10.906] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:16:0) after 8m44s
[06:04:55.009] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:16:0)
[06:04:55.038] Build status: STARTED
[06:04:55.038] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:17:0) after 7m9s
[06:12:04.094] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:17:0)
[06:12:04.118] Build status: STARTED
[06:12:04.118] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:18:0) after 9m53s
[06:21:57.188] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:18:0)
[06:21:57.205] Build status: STARTED
[06:21:57.205] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:19:0) after 4m52s
[06:26:49.218] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:19:0)
[06:26:49.243] Build status: STARTED
[06:26:49.243] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:20:0) after 4m20s
[06:31:09.306] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:20:0)
[06:31:09.337] Build status: STARTED
[06:31:09.337] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:21:0) after 4m40s
[06:35:49.401] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:21:0)
[06:35:49.433] Build status: STARTED
[06:35:49.433] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:22:0) after 9m44s
[06:45:33.460] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:22:0)
[06:45:33.483] Build status: STARTED
[06:45:33.483] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:23:0) after 1m6s
[06:46:39.596] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:23:0)
[06:46:39.612] Build status: STARTED
[06:46:39.612] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:24:0) after 3m56s
[06:50:35.648] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:24:0)
[06:50:35.676] Build status: STARTED
[06:50:35.676] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:25:0) after 5m11s
[06:55:46.718] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:25:0)
[06:55:46.760] Build status: STARTED
[06:55:46.760] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:26:0) after 9m28s
[07:05:14.814] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:26:0)
[07:05:14.847] Build status: STARTED
[07:05:14.847] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:27:0) after 7m24s
[07:12:38.956] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:27:0)
[07:12:38.987] Build status: STARTED
[07:12:38.987] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8926466896207440368:28:0) after 1m33s
[07:12:57.154] Received PubSub notification, asking Buildbucket for the build status
[07:12:57.171] Build:
{
"id": "8761036833642310273",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 224,
"createdBy": "project:dart",
"createTime": "2023-12-22T05:00:08.874061211Z",
"startTime": "2023-12-22T05:00:35.149855Z",
"endTime": "2023-12-22T07:12:53.372345Z",
"updateTime": "2023-12-22T07:12:53.372345Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "3e09072221b5fe4e8ea3d4fb69f120af8aa499cd",
"ref": "refs/heads/main"
}
}
}
[07:12:57.171] Invocation finished in 2h12m50.127426131s with status SUCCEEDED