[18:14:45.391] New invocation is queued and will start shortly
[18:14:46.937] Starting the invocation (attempt 1)
[18:14:46.970] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/monorepo/+/d160cd0214d11161fe2132bc105f53d0b925c82f"
[18:14:46.970] Popped gitiles commit info from properties and tags
[18:14:46.970] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:14:46.971] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:14:46.971] Buildbucket request:
{
"requestId": "8879487673251283664",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879487673251283664",
"job": "dart/flutter-linux",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "567b27eeef138cbbdf72ae4364430d42e2e28e27"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@567b27eeef138cbbdf72ae4364430d42e2e28e27",
"title": "567b27eeef138cbbdf72ae4364430d42e2e28e27",
"url": "https://dart.googlesource.com/monorepo//+/567b27eeef138cbbdf72ae4364430d42e2e28e27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "34146526eb88f1b2163d177427bb7507a568596c"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@34146526eb88f1b2163d177427bb7507a568596c",
"title": "34146526eb88f1b2163d177427bb7507a568596c",
"url": "https://dart.googlesource.com/monorepo//+/34146526eb88f1b2163d177427bb7507a568596c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "2a41fa8656d6656f701a4cfc410d0351934ad338"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@2a41fa8656d6656f701a4cfc410d0351934ad338",
"title": "2a41fa8656d6656f701a4cfc410d0351934ad338",
"url": "https://dart.googlesource.com/monorepo//+/2a41fa8656d6656f701a4cfc410d0351934ad338"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "dc247393e5d57e88f1a9489675b52eb6b92ae39e"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@dc247393e5d57e88f1a9489675b52eb6b92ae39e",
"title": "dc247393e5d57e88f1a9489675b52eb6b92ae39e",
"url": "https://dart.googlesource.com/monorepo//+/dc247393e5d57e88f1a9489675b52eb6b92ae39e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "db43825a1d951882dd2dff0c61dc3e1d665d5a8a"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@db43825a1d951882dd2dff0c61dc3e1d665d5a8a",
"title": "db43825a1d951882dd2dff0c61dc3e1d665d5a8a",
"url": "https://dart.googlesource.com/monorepo//+/db43825a1d951882dd2dff0c61dc3e1d665d5a8a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "f89f2ad10ce822405a2bd837c6b7929f7a46d187"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@f89f2ad10ce822405a2bd837c6b7929f7a46d187",
"title": "f89f2ad10ce822405a2bd837c6b7929f7a46d187",
"url": "https://dart.googlesource.com/monorepo//+/f89f2ad10ce822405a2bd837c6b7929f7a46d187"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "95c82b8a468d879d1069e9ec5991590339d96156"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@95c82b8a468d879d1069e9ec5991590339d96156",
"title": "95c82b8a468d879d1069e9ec5991590339d96156",
"url": "https://dart.googlesource.com/monorepo//+/95c82b8a468d879d1069e9ec5991590339d96156"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "9a7296b867a115525db49a7c0b11e4740aa708b2"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@9a7296b867a115525db49a7c0b11e4740aa708b2",
"title": "9a7296b867a115525db49a7c0b11e4740aa708b2",
"url": "https://dart.googlesource.com/monorepo//+/9a7296b867a115525db49a7c0b11e4740aa708b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "4fb41feab00c8db3342c54fb96ff45e4680f9fd4"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@4fb41feab00c8db3342c54fb96ff45e4680f9fd4",
"title": "4fb41feab00c8db3342c54fb96ff45e4680f9fd4",
"url": "https://dart.googlesource.com/monorepo//+/4fb41feab00c8db3342c54fb96ff45e4680f9fd4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "f5dd06540db8860bfd98afb7d63900f9a6c1e924"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@f5dd06540db8860bfd98afb7d63900f9a6c1e924",
"title": "f5dd06540db8860bfd98afb7d63900f9a6c1e924",
"url": "https://dart.googlesource.com/monorepo//+/f5dd06540db8860bfd98afb7d63900f9a6c1e924"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "c61515f292dd2869f08fbd2d8977b0d5946b0b67"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@c61515f292dd2869f08fbd2d8977b0d5946b0b67",
"title": "c61515f292dd2869f08fbd2d8977b0d5946b0b67",
"url": "https://dart.googlesource.com/monorepo//+/c61515f292dd2869f08fbd2d8977b0d5946b0b67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "b723515d4c5bfc0e60f4f718e355501228e4c6cc"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@b723515d4c5bfc0e60f4f718e355501228e4c6cc",
"title": "b723515d4c5bfc0e60f4f718e355501228e4c6cc",
"url": "https://dart.googlesource.com/monorepo//+/b723515d4c5bfc0e60f4f718e355501228e4c6cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/monorepo/",
"revision": "d160cd0214d11161fe2132bc105f53d0b925c82f"
},
"id": "https://dart.googlesource.com/monorepo//+/refs/heads/main@d160cd0214d11161fe2132bc105f53d0b925c82f",
"title": "d160cd0214d11161fe2132bc105f53d0b925c82f",
"url": "https://dart.googlesource.com/monorepo//+/d160cd0214d11161fe2132bc105f53d0b925c82f"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "d160cd0214d11161fe2132bc105f53d0b925c82f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879487673251283664"
},
{
"key": "scheduler_job_id",
"value": "dart/flutter-linux"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:14:47.514] Scheduled build:
{
"id": "8714057610835160129",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-linux"
},
"number": 11319,
"createdBy": "project:dart",
"createTime": "2025-05-23T18:14:47.070839996Z",
"updateTime": "2025-05-23T18:14:47.070839996Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "d160cd0214d11161fe2132bc105f53d0b925c82f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:14:47.514] Task URL: https://cr-buildbucket.appspot.com/build/8714057610835160129
[18:14:47.514] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:2:0) after 9m37s
[18:14:48.504] Received PubSub notification, asking Buildbucket for the build status
[18:14:48.548] Build status: SCHEDULED
[18:23:21.009] Received PubSub notification, asking Buildbucket for the build status
[18:23:21.029] Build status: STARTED
[18:24:24.649] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:2:0)
[18:24:24.680] Build status: STARTED
[18:24:24.680] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:5:0) after 1m59s
[18:26:23.816] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:5:0)
[18:26:23.844] Build status: STARTED
[18:26:23.844] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:6:0) after 6m13s
[18:32:36.872] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:6:0)
[18:32:36.897] Build status: STARTED
[18:32:36.898] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:7:0) after 4m22s
[18:36:58.912] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:7:0)
[18:36:58.932] Build status: STARTED
[18:36:58.932] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:8:0) after 4m11s
[18:41:09.983] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:8:0)
[18:41:10.009] Build status: STARTED
[18:41:10.009] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:9:0) after 8m55s
[18:50:05.031] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:9:0)
[18:50:05.085] Build status: STARTED
[18:50:05.085] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:10:0) after 2m56s
[18:53:01.156] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:10:0)
[18:53:01.182] Build status: STARTED
[18:53:01.182] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:11:0) after 3m51s
[18:56:52.285] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:11:0)
[18:56:52.536] Build status: STARTED
[18:56:52.536] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:12:0) after 1m28s
[18:58:20.629] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:12:0)
[18:58:20.699] Build status: STARTED
[18:58:20.699] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:13:0) after 7m1s
[19:05:21.889] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:13:0)
[19:05:21.920] Build status: STARTED
[19:05:21.920] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:14:0) after 8m58s
[19:14:19.951] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:14:0)
[19:14:19.972] Build status: STARTED
[19:14:19.972] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:15:0) after 9m0s
[19:23:20.140] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:15:0)
[19:23:20.242] Build status: STARTED
[19:23:20.242] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:16:0) after 8m12s
[19:31:32.270] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:16:0)
[19:31:32.378] Build status: STARTED
[19:31:32.378] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:17:0) after 8m57s
[19:40:29.499] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:17:0)
[19:40:29.517] Build status: STARTED
[19:40:29.517] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:18:0) after 8m37s
[19:49:06.539] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:18:0)
[19:49:06.557] Build status: STARTED
[19:49:06.557] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:19:0) after 2m12s
[19:51:18.588] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:19:0)
[19:51:18.627] Build status: STARTED
[19:51:18.627] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:20:0) after 8m24s
[19:59:42.701] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:20:0)
[19:59:42.722] Build status: STARTED
[19:59:42.722] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:21:0) after 3m42s
[20:03:24.794] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:21:0)
[20:03:24.866] Build status: STARTED
[20:03:24.866] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:22:0) after 2m32s
[20:05:56.883] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:22:0)
[20:05:56.910] Build status: STARTED
[20:05:56.910] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:23:0) after 3m2s
[20:08:58.946] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:23:0)
[20:08:58.968] Build status: STARTED
[20:08:58.968] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:24:0) after 7m48s
[20:16:47.016] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:24:0)
[20:16:47.055] Build status: STARTED
[20:16:47.055] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:25:0) after 1m8s
[20:17:55.072] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:25:0)
[20:17:55.089] Build status: STARTED
[20:17:55.089] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:26:0) after 2m5s
[20:20:00.114] Handling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:26:0)
[20:20:00.138] Build status: STARTED
[20:20:00.138] Scheduling timer "check-buildbucket-build-status" (dart/flutter-linux:8879487673251283664:27:0) after 9m8s
[20:24:54.502] Received PubSub notification, asking Buildbucket for the build status
[20:24:54.538] Build:
{
"id": "8714057610835160129",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "flutter-linux"
},
"number": 11319,
"createdBy": "project:dart",
"createTime": "2025-05-23T18:14:47.070839996Z",
"startTime": "2025-05-23T18:23:20.803823947Z",
"endTime": "2025-05-23T20:24:54.295327640Z",
"updateTime": "2025-05-23T20:24:54.295327640Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "monorepo",
"id": "d160cd0214d11161fe2132bc105f53d0b925c82f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:24:54.538] Invocation finished in 2h10m9.155954234s with status SUCCEEDED