[21:36:38.935] New invocation is queued and will start shortly
[21:36:40.048] Starting the invocation (attempt 1)
[21:36:40.086] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/f111a2df5408b5eda0e1a34cb42af113db5172f7"
[21:36:40.086] Popped gitiles commit info from properties and tags
[21:36:40.086] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:36:40.086] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:36:40.086] Buildbucket request:
{
"requestId": "8977319695006131296",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "pkg-linux-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8977319695006131296",
"job": "dart/pkg-linux-debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6e27d2458ff43af439c3873c95b29cf91843ebff"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6e27d2458ff43af439c3873c95b29cf91843ebff",
"title": "6e27d2458ff43af439c3873c95b29cf91843ebff",
"url": "https://dart.googlesource.com/sdk/+/6e27d2458ff43af439c3873c95b29cf91843ebff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1fddb10107e37ba2761a966fe21308d17bd9a903"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1fddb10107e37ba2761a966fe21308d17bd9a903",
"title": "1fddb10107e37ba2761a966fe21308d17bd9a903",
"url": "https://dart.googlesource.com/sdk/+/1fddb10107e37ba2761a966fe21308d17bd9a903"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "d9f45805f153de329a3bcdb5290e9b07bf078f6e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@d9f45805f153de329a3bcdb5290e9b07bf078f6e",
"title": "d9f45805f153de329a3bcdb5290e9b07bf078f6e",
"url": "https://dart.googlesource.com/sdk/+/d9f45805f153de329a3bcdb5290e9b07bf078f6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "743573cb262f50841aa90c3c6d2c61e2baeb144e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@743573cb262f50841aa90c3c6d2c61e2baeb144e",
"title": "743573cb262f50841aa90c3c6d2c61e2baeb144e",
"url": "https://dart.googlesource.com/sdk/+/743573cb262f50841aa90c3c6d2c61e2baeb144e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6a1749edbc4bc6103f437bc5159d871d951dc660"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6a1749edbc4bc6103f437bc5159d871d951dc660",
"title": "6a1749edbc4bc6103f437bc5159d871d951dc660",
"url": "https://dart.googlesource.com/sdk/+/6a1749edbc4bc6103f437bc5159d871d951dc660"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ca205612d666ce179ed6f309876c0b1da216c2cf"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ca205612d666ce179ed6f309876c0b1da216c2cf",
"title": "ca205612d666ce179ed6f309876c0b1da216c2cf",
"url": "https://dart.googlesource.com/sdk/+/ca205612d666ce179ed6f309876c0b1da216c2cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6b04565db2a345867e7ecf56e838321cc85a4e28"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6b04565db2a345867e7ecf56e838321cc85a4e28",
"title": "6b04565db2a345867e7ecf56e838321cc85a4e28",
"url": "https://dart.googlesource.com/sdk/+/6b04565db2a345867e7ecf56e838321cc85a4e28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "09d98f1a3a89e43f233e9ec6b8cda54950179a23"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@09d98f1a3a89e43f233e9ec6b8cda54950179a23",
"title": "09d98f1a3a89e43f233e9ec6b8cda54950179a23",
"url": "https://dart.googlesource.com/sdk/+/09d98f1a3a89e43f233e9ec6b8cda54950179a23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3e17635bca7c90a88440f3fced7cfcf324ce1c19"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3e17635bca7c90a88440f3fced7cfcf324ce1c19",
"title": "3e17635bca7c90a88440f3fced7cfcf324ce1c19",
"url": "https://dart.googlesource.com/sdk/+/3e17635bca7c90a88440f3fced7cfcf324ce1c19"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3fd96e2cb8ee5c5fed7655fa69279148cdea9403"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3fd96e2cb8ee5c5fed7655fa69279148cdea9403",
"title": "3fd96e2cb8ee5c5fed7655fa69279148cdea9403",
"url": "https://dart.googlesource.com/sdk/+/3fd96e2cb8ee5c5fed7655fa69279148cdea9403"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f111a2df5408b5eda0e1a34cb42af113db5172f7"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f111a2df5408b5eda0e1a34cb42af113db5172f7",
"title": "f111a2df5408b5eda0e1a34cb42af113db5172f7",
"url": "https://dart.googlesource.com/sdk/+/f111a2df5408b5eda0e1a34cb42af113db5172f7"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "f111a2df5408b5eda0e1a34cb42af113db5172f7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977319695006131296"
},
{
"key": "scheduler_job_id",
"value": "dart/pkg-linux-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:36:40.578] Scheduled build:
{
"id": "8811889633037381025",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "pkg-linux-debug"
},
"number": 14528,
"createdBy": "project:dart",
"createTime": "2022-06-08T21:36:40.173459490Z",
"updateTime": "2022-06-08T21:36:40.173459490Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "f111a2df5408b5eda0e1a34cb42af113db5172f7",
"ref": "refs/heads/main"
}
}
}
[21:36:40.579] Task URL: https://cr-buildbucket.appspot.com/build/8811889633037381025
[21:36:40.579] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:2:0) after 9m16s
[21:45:56.836] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:2:0)
[21:45:56.875] Build status: SCHEDULED
[21:45:56.875] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:3:0) after 8m40s
[21:54:36.992] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:3:0)
[21:54:37.027] Build status: SCHEDULED
[21:54:37.027] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:4:0) after 2m59s
[21:57:36.395] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:4:0)
[21:57:36.428] Build status: SCHEDULED
[21:57:36.428] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:5:0) after 5m49s
[22:02:21.117] Received PubSub notification, asking Buildbucket for the build status
[22:02:21.157] Build status: STARTED
[22:03:25.448] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:5:0)
[22:03:25.479] Build status: STARTED
[22:03:25.479] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:7:0) after 7m29s
[22:10:54.508] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:7:0)
[22:10:54.541] Build status: STARTED
[22:10:54.541] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:8:0) after 7m8s
[22:18:02.558] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:8:0)
[22:18:02.581] Build status: STARTED
[22:18:02.581] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:9:0) after 5m42s
[22:23:44.684] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:9:0)
[22:23:44.705] Build status: STARTED
[22:23:44.705] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:10:0) after 3m22s
[22:27:06.725] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:10:0)
[22:27:06.757] Build status: STARTED
[22:27:06.757] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:11:0) after 6m27s
[22:33:34.174] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:11:0)
[22:33:34.210] Build status: STARTED
[22:33:34.210] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:12:0) after 1m48s
[22:35:22.597] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:12:0)
[22:35:22.635] Build status: STARTED
[22:35:22.635] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:13:0) after 7m4s
[22:42:26.928] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:13:0)
[22:42:26.949] Build status: STARTED
[22:42:26.950] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:14:0) after 2m4s
[22:44:31.251] Handling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:14:0)
[22:44:31.360] Build status: STARTED
[22:44:31.360] Scheduling timer "check-buildbucket-build-status" (dart/pkg-linux-debug:8977319695006131296:15:0) after 5m5s
[22:47:00.485] Received PubSub notification, asking Buildbucket for the build status
[22:47:00.517] Build:
{
"id": "8811889633037381025",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "pkg-linux-debug"
},
"number": 14528,
"createdBy": "project:dart",
"createTime": "2022-06-08T21:36:40.173459490Z",
"startTime": "2022-06-08T22:02:19.301736Z",
"endTime": "2022-06-08T22:47:00.193536499Z",
"updateTime": "2022-06-08T22:47:00.193536499Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "f111a2df5408b5eda0e1a34cb42af113db5172f7",
"ref": "refs/heads/main"
}
}
}
[22:47:00.517] Invocation finished in 1h10m21.60541647s with status SUCCEEDED