[16:38:38.598] New invocation is queued and will start shortly
[16:38:39.821] Starting the invocation (attempt 1)
[16:38:39.857] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6965dab7b9b185da41a8296f2eb451d015b62286"
[16:38:39.857] Popped gitiles commit info from properties and tags
[16:38:39.857] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:39.857] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:39.857] Buildbucket request:
{
"requestId": "8896254158959950032",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896254158959950032",
"job": "chromium-m132/chromeos-amd64-generic-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ab28c082a9c3af7fc4c31f87c2d661ac80be3dee"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@ab28c082a9c3af7fc4c31f87c2d661ac80be3dee",
"title": "ab28c082a9c3af7fc4c31f87c2d661ac80be3dee",
"url": "https://chromium.googlesource.com/chromium/src/+/ab28c082a9c3af7fc4c31f87c2d661ac80be3dee"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "76a0d3289e7b2e2cc021af9a92d41b5309a3cca8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@76a0d3289e7b2e2cc021af9a92d41b5309a3cca8",
"title": "76a0d3289e7b2e2cc021af9a92d41b5309a3cca8",
"url": "https://chromium.googlesource.com/chromium/src/+/76a0d3289e7b2e2cc021af9a92d41b5309a3cca8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "372d1d97f9b2bd4a26febb19332d07ac83f5801a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@372d1d97f9b2bd4a26febb19332d07ac83f5801a",
"title": "372d1d97f9b2bd4a26febb19332d07ac83f5801a",
"url": "https://chromium.googlesource.com/chromium/src/+/372d1d97f9b2bd4a26febb19332d07ac83f5801a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fcb6fcf53d2f902a3d0491f5c7f628d9466228a3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@fcb6fcf53d2f902a3d0491f5c7f628d9466228a3",
"title": "fcb6fcf53d2f902a3d0491f5c7f628d9466228a3",
"url": "https://chromium.googlesource.com/chromium/src/+/fcb6fcf53d2f902a3d0491f5c7f628d9466228a3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "37ef892727bad35f514a1b78f341098d511112c8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@37ef892727bad35f514a1b78f341098d511112c8",
"title": "37ef892727bad35f514a1b78f341098d511112c8",
"url": "https://chromium.googlesource.com/chromium/src/+/37ef892727bad35f514a1b78f341098d511112c8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b3c6116bd1de65a1704422f742f7cb6c34f02215"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@b3c6116bd1de65a1704422f742f7cb6c34f02215",
"title": "b3c6116bd1de65a1704422f742f7cb6c34f02215",
"url": "https://chromium.googlesource.com/chromium/src/+/b3c6116bd1de65a1704422f742f7cb6c34f02215"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6965dab7b9b185da41a8296f2eb451d015b62286"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@6965dab7b9b185da41a8296f2eb451d015b62286",
"title": "6965dab7b9b185da41a8296f2eb451d015b62286",
"url": "https://chromium.googlesource.com/chromium/src/+/6965dab7b9b185da41a8296f2eb451d015b62286"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6965dab7b9b185da41a8296f2eb451d015b62286",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896254158959950032"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/chromeos-amd64-generic-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:38:40.457] Scheduled build:
{
"id": "8730824096911063089",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"number": 306,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-19T16:38:39.923197352Z",
"updateTime": "2024-11-19T16:38:39.923197352Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6965dab7b9b185da41a8296f2eb451d015b62286",
"ref": "refs/branch-heads/6834"
}
}
}
[16:38:40.457] Task URL: https://cr-buildbucket.appspot.com/build/8730824096911063089
[16:38:40.457] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:2:0) after 1m8s
[16:38:41.426] Received PubSub notification, asking Buildbucket for the build status
[16:38:41.449] Build status: SCHEDULED
[16:39:48.472] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:2:0)
[16:39:48.501] Build status: SCHEDULED
[16:39:48.501] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:4:0) after 2m4s
[16:41:52.542] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:4:0)
[16:41:52.603] Build status: SCHEDULED
[16:41:52.603] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:5:0) after 8m43s
[16:49:05.926] Received PubSub notification, asking Buildbucket for the build status
[16:49:05.995] Build status: STARTED
[16:50:35.604] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:5:0)
[16:50:35.673] Build status: STARTED
[16:50:35.673] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:7:0) after 8m19s
[16:58:54.692] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:7:0)
[16:58:54.742] Build status: STARTED
[16:58:54.742] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:8:0) after 7m47s
[17:06:41.775] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:8:0)
[17:06:41.812] Build status: STARTED
[17:06:41.812] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:9:0) after 9m46s
[17:16:27.884] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:9:0)
[17:16:27.902] Build status: STARTED
[17:16:27.902] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:10:0) after 4m59s
[17:21:26.950] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:10:0)
[17:21:26.975] Build status: STARTED
[17:21:26.975] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:11:0) after 9m27s
[17:30:53.993] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:11:0)
[17:30:54.007] Build status: STARTED
[17:30:54.007] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:12:0) after 3m30s
[17:34:24.023] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:12:0)
[17:34:24.041] Build status: STARTED
[17:34:24.041] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:13:0) after 7m7s
[17:41:31.061] Handling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:13:0)
[17:41:31.085] Build status: STARTED
[17:41:31.085] Scheduling timer "check-buildbucket-build-status" (chromium-m132/chromeos-amd64-generic-dbg:8896254158959950032:14:0) after 5m33s
[17:45:36.405] Received PubSub notification, asking Buildbucket for the build status
[17:45:36.455] Build:
{
"id": "8730824096911063089",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "chromeos-amd64-generic-dbg"
},
"number": 306,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-19T16:38:39.923197352Z",
"startTime": "2024-11-19T16:49:05.718403280Z",
"endTime": "2024-11-19T17:45:28.432652420Z",
"updateTime": "2024-11-19T17:45:28.432652420Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6965dab7b9b185da41a8296f2eb451d015b62286",
"ref": "refs/branch-heads/6834"
}
}
}
[17:45:36.455] Invocation finished in 1h6m57.869913746s with status SUCCEEDED