[05:00:07.360] New invocation is queued and will start shortly
[05:00:09.373] Starting the invocation (attempt 1)
[05:00:09.407] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/5a6b2421bf8db90b32f1135bd076309193cf7e07"
[05:00:09.407] Popped gitiles commit info from properties and tags
[05:00:09.407] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:09.408] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:09.408] Buildbucket request:
{
"requestId": "8913239738795238848",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913239738795238848",
"job": "dart/vm-msvc-windows",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "de68b22e8429144c5aa64a8ad07873f9e2b18074"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@de68b22e8429144c5aa64a8ad07873f9e2b18074",
"title": "de68b22e8429144c5aa64a8ad07873f9e2b18074",
"url": "https://dart.googlesource.com/sdk/+/de68b22e8429144c5aa64a8ad07873f9e2b18074"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0307423810891d7891c8fe73722d4345c482c832"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0307423810891d7891c8fe73722d4345c482c832",
"title": "0307423810891d7891c8fe73722d4345c482c832",
"url": "https://dart.googlesource.com/sdk/+/0307423810891d7891c8fe73722d4345c482c832"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3afb61aa7a1bd1b97e4e2baef6e4b2c21e5fac98"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3afb61aa7a1bd1b97e4e2baef6e4b2c21e5fac98",
"title": "3afb61aa7a1bd1b97e4e2baef6e4b2c21e5fac98",
"url": "https://dart.googlesource.com/sdk/+/3afb61aa7a1bd1b97e4e2baef6e4b2c21e5fac98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "732d95288a55038d12b7e929f9abdfa7c95ea113"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@732d95288a55038d12b7e929f9abdfa7c95ea113",
"title": "732d95288a55038d12b7e929f9abdfa7c95ea113",
"url": "https://dart.googlesource.com/sdk/+/732d95288a55038d12b7e929f9abdfa7c95ea113"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4bf22f41f388579674e2f91ad78e725adcba2871"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4bf22f41f388579674e2f91ad78e725adcba2871",
"title": "4bf22f41f388579674e2f91ad78e725adcba2871",
"url": "https://dart.googlesource.com/sdk/+/4bf22f41f388579674e2f91ad78e725adcba2871"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ae03b57cbb47189484d6aa35a4f1959c5ae29b95"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ae03b57cbb47189484d6aa35a4f1959c5ae29b95",
"title": "ae03b57cbb47189484d6aa35a4f1959c5ae29b95",
"url": "https://dart.googlesource.com/sdk/+/ae03b57cbb47189484d6aa35a4f1959c5ae29b95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0299c05481cfddd4f17e0aa6f596e5a5306b132e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0299c05481cfddd4f17e0aa6f596e5a5306b132e",
"title": "0299c05481cfddd4f17e0aa6f596e5a5306b132e",
"url": "https://dart.googlesource.com/sdk/+/0299c05481cfddd4f17e0aa6f596e5a5306b132e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "da4bf60a09563dcc545aad070b149a8a0b47cb84"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@da4bf60a09563dcc545aad070b149a8a0b47cb84",
"title": "da4bf60a09563dcc545aad070b149a8a0b47cb84",
"url": "https://dart.googlesource.com/sdk/+/da4bf60a09563dcc545aad070b149a8a0b47cb84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1e6c9b026f03e601c3941d2e3a71782ff85f91e1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1e6c9b026f03e601c3941d2e3a71782ff85f91e1",
"title": "1e6c9b026f03e601c3941d2e3a71782ff85f91e1",
"url": "https://dart.googlesource.com/sdk/+/1e6c9b026f03e601c3941d2e3a71782ff85f91e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "10429f4e891e1ea5493e5760755027dbf0f8e811"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@10429f4e891e1ea5493e5760755027dbf0f8e811",
"title": "10429f4e891e1ea5493e5760755027dbf0f8e811",
"url": "https://dart.googlesource.com/sdk/+/10429f4e891e1ea5493e5760755027dbf0f8e811"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "30e4861d9bef7eb473cb34ca24d5bb198a2e3f6c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@30e4861d9bef7eb473cb34ca24d5bb198a2e3f6c",
"title": "30e4861d9bef7eb473cb34ca24d5bb198a2e3f6c",
"url": "https://dart.googlesource.com/sdk/+/30e4861d9bef7eb473cb34ca24d5bb198a2e3f6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5c9c98c3efe83ca0e14c8a3a2ef12ad4dc5ce516"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5c9c98c3efe83ca0e14c8a3a2ef12ad4dc5ce516",
"title": "5c9c98c3efe83ca0e14c8a3a2ef12ad4dc5ce516",
"url": "https://dart.googlesource.com/sdk/+/5c9c98c3efe83ca0e14c8a3a2ef12ad4dc5ce516"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e8abe2711c6fa6ea3182784267e539fa27d154bf"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e8abe2711c6fa6ea3182784267e539fa27d154bf",
"title": "e8abe2711c6fa6ea3182784267e539fa27d154bf",
"url": "https://dart.googlesource.com/sdk/+/e8abe2711c6fa6ea3182784267e539fa27d154bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "38d7d5d66357c21c442d0db5d8efd9acc6f98164"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@38d7d5d66357c21c442d0db5d8efd9acc6f98164",
"title": "38d7d5d66357c21c442d0db5d8efd9acc6f98164",
"url": "https://dart.googlesource.com/sdk/+/38d7d5d66357c21c442d0db5d8efd9acc6f98164"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5a6b2421bf8db90b32f1135bd076309193cf7e07"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5a6b2421bf8db90b32f1135bd076309193cf7e07",
"title": "5a6b2421bf8db90b32f1135bd076309193cf7e07",
"url": "https://dart.googlesource.com/sdk/+/5a6b2421bf8db90b32f1135bd076309193cf7e07"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "5a6b2421bf8db90b32f1135bd076309193cf7e07",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913239738795238848"
},
{
"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:10.133] Scheduled build:
{
"id": "8747809675873174609",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 344,
"createdBy": "project:dart",
"createTime": "2024-05-16T05:00:09.517631634Z",
"updateTime": "2024-05-16T05:00:09.517631634Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "5a6b2421bf8db90b32f1135bd076309193cf7e07",
"ref": "refs/heads/main"
}
}
}
[05:00:10.133] Task URL: https://cr-buildbucket.appspot.com/build/8747809675873174609
[05:00:10.133] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:2:0) after 4m9s
[05:00:11.704] Received PubSub notification, asking Buildbucket for the build status
[05:00:11.773] Build status: SCHEDULED
[05:00:30.767] Received PubSub notification, asking Buildbucket for the build status
[05:00:30.798] Build status: STARTED
[05:04:19.149] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:2:0)
[05:04:19.175] Build status: STARTED
[05:04:19.175] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:5:0) after 9m40s
[05:13:59.193] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:5:0)
[05:13:59.216] Build status: STARTED
[05:13:59.216] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:6:0) after 1m33s
[05:15:32.329] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:6:0)
[05:15:32.349] Build status: STARTED
[05:15:32.349] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:7:0) after 3m59s
[05:19:31.421] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:7:0)
[05:19:31.442] Build status: STARTED
[05:19:31.443] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:8:0) after 3m13s
[05:22:44.489] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:8:0)
[05:22:44.510] Build status: STARTED
[05:22:44.510] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:9:0) after 7m26s
[05:30:10.536] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:9:0)
[05:30:10.555] Build status: STARTED
[05:30:10.555] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:10:0) after 4m45s
[05:34:55.676] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:10:0)
[05:34:55.698] Build status: STARTED
[05:34:55.698] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:11:0) after 3m18s
[05:38:13.882] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:11:0)
[05:38:13.903] Build status: STARTED
[05:38:13.903] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:12:0) after 1m35s
[05:39:49.288] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:12:0)
[05:39:49.350] Build status: STARTED
[05:39:49.350] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:13:0) after 5m18s
[05:45:07.425] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:13:0)
[05:45:07.447] Build status: STARTED
[05:45:07.447] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:14:0) after 3m10s
[05:48:17.548] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:14:0)
[05:48:17.577] Build status: STARTED
[05:48:17.577] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:15:0) after 2m38s
[05:50:55.680] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:15:0)
[05:50:55.695] Build status: STARTED
[05:50:55.695] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:16:0) after 7m16s
[05:58:12.384] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:16:0)
[05:58:12.464] Build status: STARTED
[05:58:12.464] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:17:0) after 2m33s
[06:00:45.488] Handling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:17:0)
[06:00:45.690] Build status: STARTED
[06:00:45.690] Scheduling timer "check-buildbucket-build-status" (dart/vm-msvc-windows:8913239738795238848:18:0) after 9m8s
[06:02:53.467] Received PubSub notification, asking Buildbucket for the build status
[06:02:53.487] Build:
{
"id": "8747809675873174609",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-msvc-windows"
},
"number": 344,
"createdBy": "project:dart",
"createTime": "2024-05-16T05:00:09.517631634Z",
"startTime": "2024-05-16T05:00:28.975733922Z",
"endTime": "2024-05-16T06:02:53.226827621Z",
"updateTime": "2024-05-16T06:02:53.226827621Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "5a6b2421bf8db90b32f1135bd076309193cf7e07",
"ref": "refs/heads/main"
}
}
}
[06:02:53.487] Invocation finished in 1h2m46.13972465s with status SUCCEEDED