[04:56:54.776] New invocation is queued and will start shortly
[04:56:56.039] Starting the invocation (attempt 1)
[04:56:56.065] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/bc14588ad1e832f165e8d6e2c5ca98ec290c4786"
[04:56:56.065] Popped gitiles commit info from properties and tags
[04:56:56.065] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:56:56.065] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:56:56.065] Buildbucket request:
{
"requestId": "8942502760872843952",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-linux-release-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8942502760872843952",
"job": "dart/vm-linux-release-arm64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "bc14588ad1e832f165e8d6e2c5ca98ec290c4786"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@bc14588ad1e832f165e8d6e2c5ca98ec290c4786",
"title": "bc14588ad1e832f165e8d6e2c5ca98ec290c4786",
"url": "https://dart.googlesource.com/sdk/+/bc14588ad1e832f165e8d6e2c5ca98ec290c4786"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "bc14588ad1e832f165e8d6e2c5ca98ec290c4786",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8942502760872843952"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-linux-release-arm64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:56:56.421] Scheduled build:
{
"id": "8777072698809749553",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-linux-release-arm64"
},
"number": 618,
"createdBy": "project:dart",
"createTime": "2023-06-28T04:56:56.122230046Z",
"updateTime": "2023-06-28T04:56:56.122230046Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "bc14588ad1e832f165e8d6e2c5ca98ec290c4786",
"ref": "refs/heads/main"
}
},
"canary": true
}
[04:56:56.421] Task URL: https://cr-buildbucket.appspot.com/build/8777072698809749553
[04:56:56.421] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:2:0) after 2m52s
[04:56:58.851] Received PubSub notification, asking Buildbucket for the build status
[04:56:58.905] Build status: STARTED
[04:59:48.452] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:2:0)
[04:59:48.471] Build status: STARTED
[04:59:48.471] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:4:0) after 4m53s
[05:04:41.674] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:4:0)
[05:04:41.694] Build status: STARTED
[05:04:41.694] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:5:0) after 8m57s
[05:13:38.710] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:5:0)
[05:13:38.726] Build status: STARTED
[05:13:38.726] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:6:0) after 9m8s
[05:22:46.808] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:6:0)
[05:22:46.937] Build status: STARTED
[05:22:46.937] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:7:0) after 2m56s
[05:25:43.029] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:7:0)
[05:25:43.052] Build status: STARTED
[05:25:43.052] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:8:0) after 8m20s
[05:34:03.119] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:8:0)
[05:34:03.136] Build status: STARTED
[05:34:03.136] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:9:0) after 2m0s
[05:36:03.370] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:9:0)
[05:36:03.402] Build status: STARTED
[05:36:03.402] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:10:0) after 1m31s
[05:37:34.432] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:10:0)
[05:37:34.463] Build status: STARTED
[05:37:34.463] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:11:0) after 2m39s
[05:40:13.581] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:11:0)
[05:40:13.600] Build status: STARTED
[05:40:13.600] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:12:0) after 6m58s
[05:47:11.705] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:12:0)
[05:47:11.729] Build status: STARTED
[05:47:11.729] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:13:0) after 8m26s
[05:55:37.943] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:13:0)
[05:55:37.966] Build status: STARTED
[05:55:37.966] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:14:0) after 7m14s
[06:02:52.083] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:14:0)
[06:02:52.120] Build status: STARTED
[06:02:52.120] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:15:0) after 4m43s
[06:07:35.111] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:15:0)
[06:07:35.169] Build status: STARTED
[06:07:35.169] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:16:0) after 3m18s
[06:10:53.229] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:16:0)
[06:10:53.245] Build status: STARTED
[06:10:53.245] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:17:0) after 6m9s
[06:17:02.505] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:17:0)
[06:17:02.521] Build status: STARTED
[06:17:02.521] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:18:0) after 7m54s
[06:24:56.606] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:18:0)
[06:24:56.625] Build status: STARTED
[06:24:56.625] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:19:0) after 9m28s
[06:34:24.783] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:19:0)
[06:34:24.805] Build status: STARTED
[06:34:24.805] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:20:0) after 5m50s
[06:40:14.819] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:20:0)
[06:40:14.837] Build status: STARTED
[06:40:14.837] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:21:0) after 7m33s
[06:47:47.853] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:21:0)
[06:47:47.883] Build status: STARTED
[06:47:47.883] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:22:0) after 1m4s
[06:48:52.142] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:22:0)
[06:48:52.219] Build status: STARTED
[06:48:52.219] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:23:0) after 2m21s
[06:51:13.305] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:23:0)
[06:51:13.400] Build status: STARTED
[06:51:13.401] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:24:0) after 5m42s
[06:56:55.549] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:24:0)
[06:56:55.567] Build status: STARTED
[06:56:55.567] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:25:0) after 6m44s
[07:03:39.591] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:25:0)
[07:03:39.615] Build status: STARTED
[07:03:39.615] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:26:0) after 4m14s
[07:07:53.670] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:26:0)
[07:07:53.688] Build status: STARTED
[07:07:53.688] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:27:0) after 7m0s
[07:14:53.713] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:27:0)
[07:14:53.731] Build status: STARTED
[07:14:53.731] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:28:0) after 8m0s
[07:22:53.774] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:28:0)
[07:22:53.818] Build status: STARTED
[07:22:53.818] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:29:0) after 8m35s
[07:31:28.843] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:29:0)
[07:31:28.860] Build status: STARTED
[07:31:28.860] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:30:0) after 4m55s
[07:36:23.939] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:30:0)
[07:36:23.957] Build status: STARTED
[07:36:23.957] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:31:0) after 2m31s
[07:38:54.972] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:31:0)
[07:38:55.064] Build status: STARTED
[07:38:55.064] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:32:0) after 3m51s
[07:42:46.111] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:32:0)
[07:42:46.151] Build status: STARTED
[07:42:46.151] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:33:0) after 4m9s
[07:46:55.382] Handling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:33:0)
[07:46:55.399] Build status: STARTED
[07:46:55.399] Scheduling timer "check-buildbucket-build-status" (dart/vm-linux-release-arm64:8942502760872843952:34:0) after 8m30s
[07:52:19.838] Received PubSub notification, asking Buildbucket for the build status
[07:52:19.861] Build:
{
"id": "8777072698809749553",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-linux-release-arm64"
},
"number": 618,
"createdBy": "project:dart",
"createTime": "2023-06-28T04:56:56.122230046Z",
"startTime": "2023-06-28T04:56:57.769957Z",
"endTime": "2023-06-28T07:52:19.518780814Z",
"updateTime": "2023-06-28T07:52:19.518780814Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "bc14588ad1e832f165e8d6e2c5ca98ec290c4786",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:52:19.861] Invocation finished in 2h55m25.090123912s with status FAILED