[23:56:32.501] New invocation is queued and will start shortly
[23:56:33.742] Starting the invocation (attempt 1)
[23:56:33.771] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/91ea69d96d1c1d3f089bc24f752099fb860ec9cb"
[23:56:33.771] Popped gitiles commit info from properties and tags
[23:56:33.771] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:56:33.771] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:56:33.771] Buildbucket request:
{
"requestId": "8955114636935988832",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-ffi-android-product-arm64c"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8955114636935988832",
"job": "dart/vm-ffi-android-product-arm64c",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "7acd3ba38025ffa4cb17d68ab49b50e7d0185d13"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@7acd3ba38025ffa4cb17d68ab49b50e7d0185d13",
"title": "7acd3ba38025ffa4cb17d68ab49b50e7d0185d13",
"url": "https://dart.googlesource.com/sdk/+/7acd3ba38025ffa4cb17d68ab49b50e7d0185d13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ec6712542c1eb71fde152f8aba1eeca1e309cc03"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ec6712542c1eb71fde152f8aba1eeca1e309cc03",
"title": "ec6712542c1eb71fde152f8aba1eeca1e309cc03",
"url": "https://dart.googlesource.com/sdk/+/ec6712542c1eb71fde152f8aba1eeca1e309cc03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "b880af5bcadeb96913719fcd2b150bcaf72195e9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@b880af5bcadeb96913719fcd2b150bcaf72195e9",
"title": "b880af5bcadeb96913719fcd2b150bcaf72195e9",
"url": "https://dart.googlesource.com/sdk/+/b880af5bcadeb96913719fcd2b150bcaf72195e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a0fce7be4dd7a410184f06344a6c071f9a2e93fc"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a0fce7be4dd7a410184f06344a6c071f9a2e93fc",
"title": "a0fce7be4dd7a410184f06344a6c071f9a2e93fc",
"url": "https://dart.googlesource.com/sdk/+/a0fce7be4dd7a410184f06344a6c071f9a2e93fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "91ea69d96d1c1d3f089bc24f752099fb860ec9cb"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@91ea69d96d1c1d3f089bc24f752099fb860ec9cb",
"title": "91ea69d96d1c1d3f089bc24f752099fb860ec9cb",
"url": "https://dart.googlesource.com/sdk/+/91ea69d96d1c1d3f089bc24f752099fb860ec9cb"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "91ea69d96d1c1d3f089bc24f752099fb860ec9cb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8955114636935988832"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-ffi-android-product-arm64c"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:56:34.165] Scheduled build:
{
"id": "8789684574820995553",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-ffi-android-product-arm64c"
},
"number": 3292,
"createdBy": "project:dart",
"createTime": "2023-02-08T23:56:33.889123632Z",
"updateTime": "2023-02-08T23:56:33.889123632Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "91ea69d96d1c1d3f089bc24f752099fb860ec9cb",
"ref": "refs/heads/main"
}
}
}
[23:56:34.165] Task URL: https://cr-buildbucket.appspot.com/build/8789684574820995553
[23:56:34.165] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:2:0) after 6m33s
[00:03:07.195] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:2:0)
[00:03:07.217] Build status: SCHEDULED
[00:03:07.217] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:3:0) after 9m47s
[00:12:54.238] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:3:0)
[00:12:54.277] Build status: SCHEDULED
[00:12:54.277] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:4:0) after 5m7s
[00:18:01.324] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:4:0)
[00:18:01.348] Build status: SCHEDULED
[00:18:01.349] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:5:0) after 8m53s
[00:26:54.367] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:5:0)
[00:26:54.393] Build status: SCHEDULED
[00:26:54.393] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:6:0) after 9m51s
[00:36:45.366] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:6:0)
[00:36:45.401] Build status: SCHEDULED
[00:36:45.401] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:7:0) after 6m57s
[00:43:42.433] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:7:0)
[00:43:42.475] Build status: SCHEDULED
[00:43:42.476] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:8:0) after 8m0s
[00:51:42.501] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:8:0)
[00:51:42.529] Build status: SCHEDULED
[00:51:42.529] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:9:0) after 1m28s
[00:53:10.607] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:9:0)
[00:53:10.671] Build status: SCHEDULED
[00:53:10.671] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:10:0) after 7m59s
[01:01:09.705] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:10:0)
[01:01:09.750] Build status: SCHEDULED
[01:01:09.750] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:11:0) after 8m14s
[01:09:23.888] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:11:0)
[01:09:23.910] Build status: SCHEDULED
[01:09:23.910] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:12:0) after 2m13s
[01:11:36.936] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:12:0)
[01:11:36.957] Build status: SCHEDULED
[01:11:36.957] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:13:0) after 1m5s
[01:12:42.024] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:13:0)
[01:12:42.046] Build status: SCHEDULED
[01:12:42.046] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:14:0) after 9m6s
[01:21:48.165] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:14:0)
[01:21:48.189] Build status: SCHEDULED
[01:21:48.189] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:15:0) after 2m57s
[01:24:45.206] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:15:0)
[01:24:45.229] Build status: SCHEDULED
[01:24:45.229] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:16:0) after 5m24s
[01:30:09.381] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:16:0)
[01:30:09.413] Build status: SCHEDULED
[01:30:09.413] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:17:0) after 2m6s
[01:32:15.453] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:17:0)
[01:32:15.477] Build status: SCHEDULED
[01:32:15.477] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:18:0) after 4m21s
[01:36:36.496] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:18:0)
[01:36:36.518] Build status: SCHEDULED
[01:36:36.518] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:19:0) after 7m9s
[01:39:19.991] Received PubSub notification, asking Buildbucket for the build status
[01:39:20.017] Build status: STARTED
[01:43:45.604] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:19:0)
[01:43:45.626] Build status: STARTED
[01:43:45.626] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:21:0) after 2m3s
[01:45:48.648] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:21:0)
[01:45:48.886] Build status: STARTED
[01:45:48.886] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-product-arm64c:8955114636935988832:22:0) after 8m15s
[01:53:36.018] Received PubSub notification, asking Buildbucket for the build status
[01:53:36.042] Build:
{
"id": "8789684574820995553",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-ffi-android-product-arm64c"
},
"number": 3292,
"createdBy": "project:dart",
"createTime": "2023-02-08T23:56:33.889123632Z",
"startTime": "2023-02-09T01:39:19.276026Z",
"endTime": "2023-02-09T01:53:35.732016851Z",
"updateTime": "2023-02-09T01:53:35.732016851Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "91ea69d96d1c1d3f089bc24f752099fb860ec9cb",
"ref": "refs/heads/main"
}
}
}
[01:53:36.042] Invocation finished in 1h57m3.554592205s with status SUCCEEDED