[05:00:06.907] New invocation is queued and will start shortly
[05:00:08.435] Starting the invocation (attempt 1)
[05:00:08.508] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/b3253d9c8b2436060096234b69860caac67efbac"
[05:00:08.509] Popped gitiles commit info from properties and tags
[05:00:08.509] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:08.509] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:08.510] Buildbucket request:
{
"requestId": "8916320036135251808",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-aot-win-debug-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916320036135251808",
"job": "dart/vm-aot-win-debug-arm64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7998c4297bb1a496adde7c325f739f4d1e7edcc4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7998c4297bb1a496adde7c325f739f4d1e7edcc4",
"title": "7998c4297bb1a496adde7c325f739f4d1e7edcc4",
"url": "https://dart.googlesource.com/sdk/+/7998c4297bb1a496adde7c325f739f4d1e7edcc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6eb220bbcf1dd7b9a2949324b96c22f58f41b404"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6eb220bbcf1dd7b9a2949324b96c22f58f41b404",
"title": "6eb220bbcf1dd7b9a2949324b96c22f58f41b404",
"url": "https://dart.googlesource.com/sdk/+/6eb220bbcf1dd7b9a2949324b96c22f58f41b404"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a873a147002a815059cddeb51ca26af0ff352cf7"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a873a147002a815059cddeb51ca26af0ff352cf7",
"title": "a873a147002a815059cddeb51ca26af0ff352cf7",
"url": "https://dart.googlesource.com/sdk/+/a873a147002a815059cddeb51ca26af0ff352cf7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3ac0c25a8ae26baf5fb9a5c160c60df4c49a1800"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3ac0c25a8ae26baf5fb9a5c160c60df4c49a1800",
"title": "3ac0c25a8ae26baf5fb9a5c160c60df4c49a1800",
"url": "https://dart.googlesource.com/sdk/+/3ac0c25a8ae26baf5fb9a5c160c60df4c49a1800"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3abc1edd95968a43a650d321ee76fa2118215ee9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3abc1edd95968a43a650d321ee76fa2118215ee9",
"title": "3abc1edd95968a43a650d321ee76fa2118215ee9",
"url": "https://dart.googlesource.com/sdk/+/3abc1edd95968a43a650d321ee76fa2118215ee9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "27648f6b3a193598796470ea3dbc00ede1dd393f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@27648f6b3a193598796470ea3dbc00ede1dd393f",
"title": "27648f6b3a193598796470ea3dbc00ede1dd393f",
"url": "https://dart.googlesource.com/sdk/+/27648f6b3a193598796470ea3dbc00ede1dd393f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7735d947066886ac2fec767e15ce8c1c1296ff1b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7735d947066886ac2fec767e15ce8c1c1296ff1b",
"title": "7735d947066886ac2fec767e15ce8c1c1296ff1b",
"url": "https://dart.googlesource.com/sdk/+/7735d947066886ac2fec767e15ce8c1c1296ff1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2c952516a85e9e61e9ccddab24bfe36a687cb257"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2c952516a85e9e61e9ccddab24bfe36a687cb257",
"title": "2c952516a85e9e61e9ccddab24bfe36a687cb257",
"url": "https://dart.googlesource.com/sdk/+/2c952516a85e9e61e9ccddab24bfe36a687cb257"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3b07865faf050e59ea7da67159873c9feb5d1954"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3b07865faf050e59ea7da67159873c9feb5d1954",
"title": "3b07865faf050e59ea7da67159873c9feb5d1954",
"url": "https://dart.googlesource.com/sdk/+/3b07865faf050e59ea7da67159873c9feb5d1954"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2f5a53c89d63a2fc76ca18fa5abe3911cb980243"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2f5a53c89d63a2fc76ca18fa5abe3911cb980243",
"title": "2f5a53c89d63a2fc76ca18fa5abe3911cb980243",
"url": "https://dart.googlesource.com/sdk/+/2f5a53c89d63a2fc76ca18fa5abe3911cb980243"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "2782a48da3658c927946169b775a7c439bc5b87c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@2782a48da3658c927946169b775a7c439bc5b87c",
"title": "2782a48da3658c927946169b775a7c439bc5b87c",
"url": "https://dart.googlesource.com/sdk/+/2782a48da3658c927946169b775a7c439bc5b87c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3888fe97e8e13a1dcb25a489e01e147d463abc70"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3888fe97e8e13a1dcb25a489e01e147d463abc70",
"title": "3888fe97e8e13a1dcb25a489e01e147d463abc70",
"url": "https://dart.googlesource.com/sdk/+/3888fe97e8e13a1dcb25a489e01e147d463abc70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "004d226a5e5caa4387bfbb38a29e88f5e02a636c"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@004d226a5e5caa4387bfbb38a29e88f5e02a636c",
"title": "004d226a5e5caa4387bfbb38a29e88f5e02a636c",
"url": "https://dart.googlesource.com/sdk/+/004d226a5e5caa4387bfbb38a29e88f5e02a636c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d70b2efdd332ebb2d3887821369027d7c681c349"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d70b2efdd332ebb2d3887821369027d7c681c349",
"title": "d70b2efdd332ebb2d3887821369027d7c681c349",
"url": "https://dart.googlesource.com/sdk/+/d70b2efdd332ebb2d3887821369027d7c681c349"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c22f054a40e01a5ef4ffc2272d449c6010ffbbed"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c22f054a40e01a5ef4ffc2272d449c6010ffbbed",
"title": "c22f054a40e01a5ef4ffc2272d449c6010ffbbed",
"url": "https://dart.googlesource.com/sdk/+/c22f054a40e01a5ef4ffc2272d449c6010ffbbed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "364ab8dfd830b8d0b50015e5bd0b5a69ac1818d2"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@364ab8dfd830b8d0b50015e5bd0b5a69ac1818d2",
"title": "364ab8dfd830b8d0b50015e5bd0b5a69ac1818d2",
"url": "https://dart.googlesource.com/sdk/+/364ab8dfd830b8d0b50015e5bd0b5a69ac1818d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d7a0f7703cf279c310a8161456eaa49fae323329"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d7a0f7703cf279c310a8161456eaa49fae323329",
"title": "d7a0f7703cf279c310a8161456eaa49fae323329",
"url": "https://dart.googlesource.com/sdk/+/d7a0f7703cf279c310a8161456eaa49fae323329"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "be02caa2d16ff7f22c499795b3bed817ab922933"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@be02caa2d16ff7f22c499795b3bed817ab922933",
"title": "be02caa2d16ff7f22c499795b3bed817ab922933",
"url": "https://dart.googlesource.com/sdk/+/be02caa2d16ff7f22c499795b3bed817ab922933"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "8af6f94b61292c25a957ee1814501d0e82b39f73"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@8af6f94b61292c25a957ee1814501d0e82b39f73",
"title": "8af6f94b61292c25a957ee1814501d0e82b39f73",
"url": "https://dart.googlesource.com/sdk/+/8af6f94b61292c25a957ee1814501d0e82b39f73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b3253d9c8b2436060096234b69860caac67efbac"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b3253d9c8b2436060096234b69860caac67efbac",
"title": "b3253d9c8b2436060096234b69860caac67efbac",
"url": "https://dart.googlesource.com/sdk/+/b3253d9c8b2436060096234b69860caac67efbac"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b3253d9c8b2436060096234b69860caac67efbac",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916320036135251808"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-aot-win-debug-arm64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:00:09.289] Scheduled build:
{
"id": "8750889973617114145",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-aot-win-debug-arm64"
},
"number": 846,
"createdBy": "project:dart",
"createTime": "2024-04-12T05:00:08.672582528Z",
"updateTime": "2024-04-12T05:00:08.672582528Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b3253d9c8b2436060096234b69860caac67efbac",
"ref": "refs/heads/main"
}
}
}
[05:00:09.289] Task URL: https://cr-buildbucket.appspot.com/build/8750889973617114145
[05:00:09.289] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:2:0) after 9m34s
[05:00:10.025] Received PubSub notification, asking Buildbucket for the build status
[05:00:10.088] Build status: SCHEDULED
[05:00:48.656] Received PubSub notification, asking Buildbucket for the build status
[05:00:48.719] Build status: STARTED
[05:09:43.451] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:2:0)
[05:09:43.472] Build status: STARTED
[05:09:43.472] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:5:0) after 7m32s
[05:17:15.545] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:5:0)
[05:17:15.568] Build status: STARTED
[05:17:15.568] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:6:0) after 9m27s
[05:26:42.653] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:6:0)
[05:26:42.686] Build status: STARTED
[05:26:42.686] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:7:0) after 8m7s
[05:34:49.869] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:7:0)
[05:34:49.924] Build status: STARTED
[05:34:49.924] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:8:0) after 3m13s
[05:38:02.947] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:8:0)
[05:38:02.969] Build status: STARTED
[05:38:02.969] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:9:0) after 7m24s
[05:45:26.995] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:9:0)
[05:45:27.028] Build status: STARTED
[05:45:27.028] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:10:0) after 7m40s
[05:53:07.218] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:10:0)
[05:53:07.384] Build status: STARTED
[05:53:07.384] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:11:0) after 6m46s
[05:59:53.542] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:11:0)
[05:59:53.571] Build status: STARTED
[05:59:53.571] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:12:0) after 5m38s
[06:05:31.612] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:12:0)
[06:05:31.637] Build status: STARTED
[06:05:31.637] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:13:0) after 2m48s
[06:08:19.665] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:13:0)
[06:08:19.727] Build status: STARTED
[06:08:19.727] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:14:0) after 2m7s
[06:10:27.004] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:14:0)
[06:10:27.037] Build status: STARTED
[06:10:27.037] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:15:0) after 8m52s
[06:19:19.405] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:15:0)
[06:19:19.439] Build status: STARTED
[06:19:19.439] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:16:0) after 6m41s
[06:26:00.456] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:16:0)
[06:26:00.478] Build status: STARTED
[06:26:00.478] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:17:0) after 7m57s
[06:33:57.523] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:17:0)
[06:33:57.561] Build status: STARTED
[06:33:57.561] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:18:0) after 2m30s
[06:36:27.579] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:18:0)
[06:36:27.598] Build status: STARTED
[06:36:27.598] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:19:0) after 2m35s
[06:39:03.142] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:19:0)
[06:39:03.160] Build status: STARTED
[06:39:03.160] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:20:0) after 5m19s
[06:44:22.201] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:20:0)
[06:44:22.221] Build status: STARTED
[06:44:22.221] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:21:0) after 6m1s
[06:50:23.301] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:21:0)
[06:50:23.334] Build status: STARTED
[06:50:23.334] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:22:0) after 2m31s
[06:52:54.352] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:22:0)
[06:52:54.504] Build status: STARTED
[06:52:54.504] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:23:0) after 4m41s
[06:57:35.594] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:23:0)
[06:57:35.619] Build status: STARTED
[06:57:35.619] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:24:0) after 5m13s
[07:02:48.899] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:24:0)
[07:02:48.928] Build status: STARTED
[07:02:48.928] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:25:0) after 2m11s
[07:05:00.004] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:25:0)
[07:05:00.119] Build status: STARTED
[07:05:00.119] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:26:0) after 9m25s
[07:14:25.138] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:26:0)
[07:14:25.160] Build status: STARTED
[07:14:25.160] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:27:0) after 7m9s
[07:21:34.371] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:27:0)
[07:21:34.399] Build status: STARTED
[07:21:34.399] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:28:0) after 2m22s
[07:23:56.481] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:28:0)
[07:23:56.523] Build status: STARTED
[07:23:56.523] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:29:0) after 5m4s
[07:29:00.554] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:29:0)
[07:29:00.583] Build status: STARTED
[07:29:00.583] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:30:0) after 1m31s
[07:30:31.613] Handling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:30:0)
[07:30:31.639] Build status: STARTED
[07:30:31.639] Scheduling timer "check-buildbucket-build-status" (dart/vm-aot-win-debug-arm64:8916320036135251808:31:0) after 7m13s
[07:36:21.569] Received PubSub notification, asking Buildbucket for the build status
[07:36:21.588] Build:
{
"id": "8750889973617114145",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-aot-win-debug-arm64"
},
"number": 846,
"createdBy": "project:dart",
"createTime": "2024-04-12T05:00:08.672582528Z",
"startTime": "2024-04-12T05:00:48.409943482Z",
"endTime": "2024-04-12T07:35:57.159202402Z",
"updateTime": "2024-04-12T07:35:57.159202402Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "b3253d9c8b2436060096234b69860caac67efbac",
"ref": "refs/heads/main"
}
}
}
[07:36:21.588] Invocation finished in 2h36m14.701133311s with status SUCCEEDED