[05:00:09.401] New invocation is queued and will start shortly
[05:00:10.815] Starting the invocation (attempt 1)
[05:00:10.844] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c"
[05:00:10.844] Popped gitiles commit info from properties and tags
[05:00:10.844] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:10.845] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:10.845] Buildbucket request:
{
"requestId": "8949931508046903072",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8949931508046903072",
"job": "dart/vm-msvc-windows",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6275efd7795a240a26b10064278eed3f42aec07f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6275efd7795a240a26b10064278eed3f42aec07f",
"title": "6275efd7795a240a26b10064278eed3f42aec07f",
"url": "https://dart.googlesource.com/sdk/+/6275efd7795a240a26b10064278eed3f42aec07f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "df761ba9e7e55dfe867759f7090e26acca529d80"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@df761ba9e7e55dfe867759f7090e26acca529d80",
"title": "df761ba9e7e55dfe867759f7090e26acca529d80",
"url": "https://dart.googlesource.com/sdk/+/df761ba9e7e55dfe867759f7090e26acca529d80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4919729f00b5c9d2c2962868f4a14815b25f6367"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4919729f00b5c9d2c2962868f4a14815b25f6367",
"title": "4919729f00b5c9d2c2962868f4a14815b25f6367",
"url": "https://dart.googlesource.com/sdk/+/4919729f00b5c9d2c2962868f4a14815b25f6367"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ab712b5fd3fa853a3b1a74586b6efce45cffd13a"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ab712b5fd3fa853a3b1a74586b6efce45cffd13a",
"title": "ab712b5fd3fa853a3b1a74586b6efce45cffd13a",
"url": "https://dart.googlesource.com/sdk/+/ab712b5fd3fa853a3b1a74586b6efce45cffd13a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "da1898e0c76e9eb9bd33392a65f44c43edb9bf39"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@da1898e0c76e9eb9bd33392a65f44c43edb9bf39",
"title": "da1898e0c76e9eb9bd33392a65f44c43edb9bf39",
"url": "https://dart.googlesource.com/sdk/+/da1898e0c76e9eb9bd33392a65f44c43edb9bf39"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e90e43138eb03a4150796c05a54417ea2de5d122"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e90e43138eb03a4150796c05a54417ea2de5d122",
"title": "e90e43138eb03a4150796c05a54417ea2de5d122",
"url": "https://dart.googlesource.com/sdk/+/e90e43138eb03a4150796c05a54417ea2de5d122"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7573d4b1ded9b63f0c1de83d53434b79bd33537f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7573d4b1ded9b63f0c1de83d53434b79bd33537f",
"title": "7573d4b1ded9b63f0c1de83d53434b79bd33537f",
"url": "https://dart.googlesource.com/sdk/+/7573d4b1ded9b63f0c1de83d53434b79bd33537f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ed369f4a07d2486a2193e2f0bb13a3cafd5c7319"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ed369f4a07d2486a2193e2f0bb13a3cafd5c7319",
"title": "ed369f4a07d2486a2193e2f0bb13a3cafd5c7319",
"url": "https://dart.googlesource.com/sdk/+/ed369f4a07d2486a2193e2f0bb13a3cafd5c7319"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "709465da6b145bdc3cae7a8e389ced92868d20a9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@709465da6b145bdc3cae7a8e389ced92868d20a9",
"title": "709465da6b145bdc3cae7a8e389ced92868d20a9",
"url": "https://dart.googlesource.com/sdk/+/709465da6b145bdc3cae7a8e389ced92868d20a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b1c0f16a5105bbfff8417b505266f48451b4ded1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b1c0f16a5105bbfff8417b505266f48451b4ded1",
"title": "b1c0f16a5105bbfff8417b505266f48451b4ded1",
"url": "https://dart.googlesource.com/sdk/+/b1c0f16a5105bbfff8417b505266f48451b4ded1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b6b8b00daa93abc68d6adb99e7676274a53b2cce"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b6b8b00daa93abc68d6adb99e7676274a53b2cce",
"title": "b6b8b00daa93abc68d6adb99e7676274a53b2cce",
"url": "https://dart.googlesource.com/sdk/+/b6b8b00daa93abc68d6adb99e7676274a53b2cce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "aca1779661caa0f9d89cef91a68dc040ce43f1f9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@aca1779661caa0f9d89cef91a68dc040ce43f1f9",
"title": "aca1779661caa0f9d89cef91a68dc040ce43f1f9",
"url": "https://dart.googlesource.com/sdk/+/aca1779661caa0f9d89cef91a68dc040ce43f1f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c08c443a5e95bd4cc1651c9cae64213401563098"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c08c443a5e95bd4cc1651c9cae64213401563098",
"title": "c08c443a5e95bd4cc1651c9cae64213401563098",
"url": "https://dart.googlesource.com/sdk/+/c08c443a5e95bd4cc1651c9cae64213401563098"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6d29fc8d8f5c8b2b91e100227783db6cec1c5423"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6d29fc8d8f5c8b2b91e100227783db6cec1c5423",
"title": "6d29fc8d8f5c8b2b91e100227783db6cec1c5423",
"url": "https://dart.googlesource.com/sdk/+/6d29fc8d8f5c8b2b91e100227783db6cec1c5423"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "033b567c2ac5999634042b97e101c724b0484897"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@033b567c2ac5999634042b97e101c724b0484897",
"title": "033b567c2ac5999634042b97e101c724b0484897",
"url": "https://dart.googlesource.com/sdk/+/033b567c2ac5999634042b97e101c724b0484897"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d83dcd59e18f8bc99ceb7b7594fd29cf29277d44"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d83dcd59e18f8bc99ceb7b7594fd29cf29277d44",
"title": "d83dcd59e18f8bc99ceb7b7594fd29cf29277d44",
"url": "https://dart.googlesource.com/sdk/+/d83dcd59e18f8bc99ceb7b7594fd29cf29277d44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e945ac605115c45e8c516cd9c5357f057902180a"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e945ac605115c45e8c516cd9c5357f057902180a",
"title": "e945ac605115c45e8c516cd9c5357f057902180a",
"url": "https://dart.googlesource.com/sdk/+/e945ac605115c45e8c516cd9c5357f057902180a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7906ccf7eae8a6812554dc3da014b0007c8331bb"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7906ccf7eae8a6812554dc3da014b0007c8331bb",
"title": "7906ccf7eae8a6812554dc3da014b0007c8331bb",
"url": "https://dart.googlesource.com/sdk/+/7906ccf7eae8a6812554dc3da014b0007c8331bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c",
"title": "0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c",
"url": "https://dart.googlesource.com/sdk/+/0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949931508046903072"
},
{
"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:11.198] Scheduled build:
{
"id": "8784501445800330593",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 3,
"createdBy": "project:dart",
"createTime": "2023-04-07T05:00:10.914530326Z",
"updateTime": "2023-04-07T05:00:10.914530326Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c",
"ref": "refs/heads/main"
}
}
}
[05:00:11.198] Task URL: https://cr-buildbucket.appspot.com/build/8784501445800330593
[05:00:11.198] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:2:0) after 6m6s
[05:00:21.453] Received PubSub notification, asking Buildbucket for the build status
[05:00:21.479] Build status: STARTED
[05:06:17.417] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:2:0)
[05:06:17.452] Build status: STARTED
[05:06:17.452] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:4:0) after 9m47s
[05:16:04.480] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:4:0)
[05:16:04.511] Build status: STARTED
[05:16:04.511] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:5:0) after 4m49s
[05:20:53.633] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:5:0)
[05:20:53.688] Build status: STARTED
[05:20:53.688] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:6:0) after 1m27s
[05:22:20.706] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:6:0)
[05:22:20.730] Build status: STARTED
[05:22:20.730] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:7:0) after 9m24s
[05:31:44.758] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:7:0)
[05:31:44.778] Build status: STARTED
[05:31:44.778] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:8:0) after 9m45s
[05:41:29.797] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:8:0)
[05:41:29.823] Build status: STARTED
[05:41:29.823] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:9:0) after 9m22s
[05:50:51.858] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:9:0)
[05:50:51.877] Build status: STARTED
[05:50:51.877] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:10:0) after 3m50s
[05:54:42.004] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:10:0)
[05:54:42.122] Build status: STARTED
[05:54:42.122] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:11:0) after 8m2s
[06:02:44.319] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:11:0)
[06:02:44.378] Build status: STARTED
[06:02:44.378] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:12:0) after 4m39s
[06:07:23.412] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:12:0)
[06:07:23.435] Build status: STARTED
[06:07:23.435] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:13:0) after 9m50s
[06:17:13.454] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:13:0)
[06:17:13.476] Build status: STARTED
[06:17:13.476] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:14:0) after 4m20s
[06:21:33.523] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:14:0)
[06:21:33.581] Build status: STARTED
[06:21:33.582] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:15:0) after 7m48s
[06:29:21.604] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:15:0)
[06:29:21.675] Build status: STARTED
[06:29:21.675] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:16:0) after 9m6s
[06:38:27.693] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:16:0)
[06:38:27.717] Build status: STARTED
[06:38:27.717] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:17:0) after 1m35s
[06:40:02.700] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:17:0)
[06:40:02.723] Build status: STARTED
[06:40:02.723] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:18:0) after 3m21s
[06:43:23.919] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:18:0)
[06:43:23.954] Build status: STARTED
[06:43:23.954] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:19:0) after 1m1s
[06:44:25.087] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:19:0)
[06:44:25.109] Build status: STARTED
[06:44:25.109] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:20:0) after 1m38s
[06:46:03.136] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:20:0)
[06:46:03.170] Build status: STARTED
[06:46:03.170] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:21:0) after 7m40s
[06:53:43.192] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:21:0)
[06:53:43.229] Build status: STARTED
[06:53:43.229] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:22:0) after 3m19s
[06:57:02.252] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:22:0)
[06:57:02.276] Build status: STARTED
[06:57:02.276] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:23:0) after 5m0s
[07:02:02.353] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:23:0)
[07:02:02.393] Build status: STARTED
[07:02:02.394] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8949931508046903072:24:0) after 2m39s
[07:03:57.352] Received PubSub notification, asking Buildbucket for the build status
[07:03:57.422] Build:
{
"id": "8784501445800330593",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 3,
"createdBy": "project:dart",
"createTime": "2023-04-07T05:00:10.914530326Z",
"startTime": "2023-04-07T05:00:20.892559Z",
"endTime": "2023-04-07T07:03:57.181380964Z",
"updateTime": "2023-04-07T07:03:57.181380964Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "0c7c721402ea6d0b7b30a18c35d4b20c5c8df67c",
"ref": "refs/heads/main"
}
}
}
[07:03:57.422] Invocation finished in 2h3m48.033977603s with status SUCCEEDED