[22:45:14.302] New invocation is queued and will start shortly
[22:45:15.352] Starting the invocation (attempt 1)
[22:45:15.382] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42fecc65efc0d096e5fb4e585339372041c9baf9"
[22:45:15.382] Popped gitiles commit info from properties and tags
[22:45:15.382] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:45:15.382] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:45:15.383] Buildbucket request:
{
"requestId": "8873853644092050608",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "linux-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873853644092050608",
"job": "chromium-m139/linux-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e0b450c071a8438df71800867f37490e5acc4ebe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@e0b450c071a8438df71800867f37490e5acc4ebe",
"title": "e0b450c071a8438df71800867f37490e5acc4ebe",
"url": "https://chromium.googlesource.com/chromium/src/+/e0b450c071a8438df71800867f37490e5acc4ebe"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aba3e035c0734b11193e1387a1e7d0c44a73f631"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@aba3e035c0734b11193e1387a1e7d0c44a73f631",
"title": "aba3e035c0734b11193e1387a1e7d0c44a73f631",
"url": "https://chromium.googlesource.com/chromium/src/+/aba3e035c0734b11193e1387a1e7d0c44a73f631"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dbcb231723d7590a3023cec8a65b263590e7682d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@dbcb231723d7590a3023cec8a65b263590e7682d",
"title": "dbcb231723d7590a3023cec8a65b263590e7682d",
"url": "https://chromium.googlesource.com/chromium/src/+/dbcb231723d7590a3023cec8a65b263590e7682d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "47bdb3e2eca3537b26bf7e213e8cd0cd57439e3a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@47bdb3e2eca3537b26bf7e213e8cd0cd57439e3a",
"title": "47bdb3e2eca3537b26bf7e213e8cd0cd57439e3a",
"url": "https://chromium.googlesource.com/chromium/src/+/47bdb3e2eca3537b26bf7e213e8cd0cd57439e3a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5a494b9c9466ea72e54e9767540fc3b209cfccef"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@5a494b9c9466ea72e54e9767540fc3b209cfccef",
"title": "5a494b9c9466ea72e54e9767540fc3b209cfccef",
"url": "https://chromium.googlesource.com/chromium/src/+/5a494b9c9466ea72e54e9767540fc3b209cfccef"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "596afcbb9aa863d81cdcc4550a5546c84a2f6fe6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@596afcbb9aa863d81cdcc4550a5546c84a2f6fe6",
"title": "596afcbb9aa863d81cdcc4550a5546c84a2f6fe6",
"url": "https://chromium.googlesource.com/chromium/src/+/596afcbb9aa863d81cdcc4550a5546c84a2f6fe6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a3d93801762f8e48ba13334041924e9c41151b1c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@a3d93801762f8e48ba13334041924e9c41151b1c",
"title": "a3d93801762f8e48ba13334041924e9c41151b1c",
"url": "https://chromium.googlesource.com/chromium/src/+/a3d93801762f8e48ba13334041924e9c41151b1c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4ed911951173ef3ceb12c835c0a65b4f3b5f17a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@4ed911951173ef3ceb12c835c0a65b4f3b5f17a2",
"title": "4ed911951173ef3ceb12c835c0a65b4f3b5f17a2",
"url": "https://chromium.googlesource.com/chromium/src/+/4ed911951173ef3ceb12c835c0a65b4f3b5f17a2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "428a284654243fef9df722f5dcfb6f5250b6cfd5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@428a284654243fef9df722f5dcfb6f5250b6cfd5",
"title": "428a284654243fef9df722f5dcfb6f5250b6cfd5",
"url": "https://chromium.googlesource.com/chromium/src/+/428a284654243fef9df722f5dcfb6f5250b6cfd5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e1153b2def1618930c860867ed09a5a03f96cfc8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@e1153b2def1618930c860867ed09a5a03f96cfc8",
"title": "e1153b2def1618930c860867ed09a5a03f96cfc8",
"url": "https://chromium.googlesource.com/chromium/src/+/e1153b2def1618930c860867ed09a5a03f96cfc8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3281d8ba2df69fc1706fde82bc9a9e4fd9df185c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@3281d8ba2df69fc1706fde82bc9a9e4fd9df185c",
"title": "3281d8ba2df69fc1706fde82bc9a9e4fd9df185c",
"url": "https://chromium.googlesource.com/chromium/src/+/3281d8ba2df69fc1706fde82bc9a9e4fd9df185c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b3ce48183e223f605e6738115eb4cc547004a7ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@b3ce48183e223f605e6738115eb4cc547004a7ab",
"title": "b3ce48183e223f605e6738115eb4cc547004a7ab",
"url": "https://chromium.googlesource.com/chromium/src/+/b3ce48183e223f605e6738115eb4cc547004a7ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "051c7e8368699c8efc190158c3aa675af25a5b33"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@051c7e8368699c8efc190158c3aa675af25a5b33",
"title": "051c7e8368699c8efc190158c3aa675af25a5b33",
"url": "https://chromium.googlesource.com/chromium/src/+/051c7e8368699c8efc190158c3aa675af25a5b33"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ca104bee6e43da5688a4c9ba0884723c8cc2d363"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@ca104bee6e43da5688a4c9ba0884723c8cc2d363",
"title": "ca104bee6e43da5688a4c9ba0884723c8cc2d363",
"url": "https://chromium.googlesource.com/chromium/src/+/ca104bee6e43da5688a4c9ba0884723c8cc2d363"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "42fecc65efc0d096e5fb4e585339372041c9baf9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@42fecc65efc0d096e5fb4e585339372041c9baf9",
"title": "42fecc65efc0d096e5fb4e585339372041c9baf9",
"url": "https://chromium.googlesource.com/chromium/src/+/42fecc65efc0d096e5fb4e585339372041c9baf9"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "42fecc65efc0d096e5fb4e585339372041c9baf9",
"ref": "refs/branch-heads/7258"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873853644092050608"
},
{
"key": "scheduler_job_id",
"value": "chromium-m139/linux-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:45:15.966] Scheduled build:
{
"id": "8708423582220117393",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "linux-official"
},
"number": 139,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-24T22:45:15.458750134Z",
"updateTime": "2025-07-24T22:45:15.458750134Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "42fecc65efc0d096e5fb4e585339372041c9baf9",
"ref": "refs/branch-heads/7258"
}
}
}
[22:45:15.966] Task URL: https://cr-buildbucket.appspot.com/build/8708423582220117393
[22:45:15.966] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:2:0) after 7m30s
[22:45:46.575] Received PubSub notification, asking Buildbucket for the build status
[22:45:46.605] Build status: STARTED
[22:45:49.237] Received PubSub notification, asking Buildbucket for the build status
[22:45:49.260] Build status: STARTED
[22:52:45.992] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:2:0)
[22:52:46.079] Build status: STARTED
[22:52:46.079] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:5:0) after 1m33s
[22:54:19.049] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:5:0)
[22:54:19.070] Build status: STARTED
[22:54:19.070] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:6:0) after 7m17s
[23:01:36.056] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:6:0)
[23:01:36.201] Build status: STARTED
[23:01:36.201] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:7:0) after 2m39s
[23:04:15.307] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:7:0)
[23:04:15.398] Build status: STARTED
[23:04:15.398] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:8:0) after 5m7s
[23:09:22.447] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:8:0)
[23:09:22.475] Build status: STARTED
[23:09:22.475] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:9:0) after 6m11s
[23:15:33.581] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:9:0)
[23:15:33.636] Build status: STARTED
[23:15:33.637] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:10:0) after 5m52s
[23:21:25.680] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:10:0)
[23:21:25.706] Build status: STARTED
[23:21:25.706] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:11:0) after 6m18s
[23:27:43.732] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:11:0)
[23:27:43.753] Build status: STARTED
[23:27:43.753] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:12:0) after 9m46s
[23:37:29.831] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:12:0)
[23:37:29.861] Build status: STARTED
[23:37:29.861] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:13:0) after 1m28s
[23:38:57.886] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:13:0)
[23:38:57.908] Build status: STARTED
[23:38:57.908] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:14:0) after 1m21s
[23:40:18.919] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:14:0)
[23:40:18.938] Build status: STARTED
[23:40:18.938] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:15:0) after 4m37s
[23:44:55.966] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:15:0)
[23:44:55.989] Build status: STARTED
[23:44:55.989] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:16:0) after 1m32s
[23:46:28.010] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:16:0)
[23:46:28.033] Build status: STARTED
[23:46:28.033] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:17:0) after 5m6s
[23:51:34.152] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:17:0)
[23:51:34.258] Build status: STARTED
[23:51:34.258] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:18:0) after 1m47s
[23:53:21.389] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:18:0)
[23:53:21.413] Build status: STARTED
[23:53:21.413] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:19:0) after 6m0s
[23:59:21.437] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:19:0)
[23:59:21.494] Build status: STARTED
[23:59:21.494] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:20:0) after 1m31s
[00:00:52.544] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:20:0)
[00:00:52.570] Build status: STARTED
[00:00:52.570] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:21:0) after 1m16s
[00:02:08.762] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:21:0)
[00:02:08.794] Build status: STARTED
[00:02:08.794] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:22:0) after 7m21s
[00:09:29.791] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:22:0)
[00:09:29.818] Build status: STARTED
[00:09:29.818] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:23:0) after 8m20s
[00:17:49.837] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:23:0)
[00:17:49.859] Build status: STARTED
[00:17:49.859] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:24:0) after 4m29s
[00:22:18.859] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:24:0)
[00:22:18.882] Build status: STARTED
[00:22:18.882] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:25:0) after 2m17s
[00:24:35.998] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:25:0)
[00:24:36.354] Build status: STARTED
[00:24:36.354] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:26:0) after 5m57s
[00:30:33.382] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:26:0)
[00:30:33.412] Build status: STARTED
[00:30:33.412] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:27:0) after 1m37s
[00:32:10.397] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:27:0)
[00:32:10.421] Build status: STARTED
[00:32:10.421] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:28:0) after 9m5s
[00:41:15.454] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:28:0)
[00:41:15.618] Build status: STARTED
[00:41:15.618] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:29:0) after 4m25s
[00:45:40.654] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:29:0)
[00:45:40.673] Build status: STARTED
[00:45:40.673] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:30:0) after 7m29s
[00:53:09.658] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:30:0)
[00:53:09.685] Build status: STARTED
[00:53:09.685] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:31:0) after 3m2s
[00:56:11.735] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:31:0)
[00:56:11.761] Build status: STARTED
[00:56:11.761] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:32:0) after 5m49s
[01:02:00.886] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:32:0)
[01:02:00.908] Build status: STARTED
[01:02:00.908] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:33:0) after 6m11s
[01:08:11.926] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:33:0)
[01:08:11.942] Build status: STARTED
[01:08:11.942] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:34:0) after 5m3s
[01:13:15.014] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:34:0)
[01:13:15.032] Build status: STARTED
[01:13:15.032] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:35:0) after 1m0s
[01:14:15.029] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:35:0)
[01:14:15.164] Build status: STARTED
[01:14:15.164] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:36:0) after 2m55s
[01:17:10.228] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:36:0)
[01:17:10.276] Build status: STARTED
[01:17:10.276] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:37:0) after 9m43s
[01:26:53.319] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:37:0)
[01:26:53.339] Build status: STARTED
[01:26:53.339] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:38:0) after 7m42s
[01:34:35.402] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:38:0)
[01:34:35.455] Build status: STARTED
[01:34:35.455] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:39:0) after 5m49s
[01:40:24.478] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:39:0)
[01:40:24.498] Build status: STARTED
[01:40:24.498] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:40:0) after 9m7s
[01:49:31.553] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:40:0)
[01:49:31.604] Build status: STARTED
[01:49:31.604] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:41:0) after 4m48s
[01:54:19.640] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:41:0)
[01:54:19.688] Build status: STARTED
[01:54:19.688] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:42:0) after 3m14s
[01:57:33.776] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:42:0)
[01:57:33.797] Build status: STARTED
[01:57:33.797] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:43:0) after 7m55s
[02:05:28.847] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:43:0)
[02:05:28.896] Build status: STARTED
[02:05:28.896] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:44:0) after 9m49s
[02:15:17.921] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:44:0)
[02:15:17.955] Build status: STARTED
[02:15:17.955] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:45:0) after 9m7s
[02:24:24.988] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:45:0)
[02:24:25.015] Build status: STARTED
[02:24:25.015] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:46:0) after 8m7s
[02:32:32.046] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:46:0)
[02:32:32.067] Build status: STARTED
[02:32:32.067] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:47:0) after 3m57s
[02:36:29.215] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:47:0)
[02:36:29.235] Build status: STARTED
[02:36:29.235] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:48:0) after 2m40s
[02:39:09.323] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:48:0)
[02:39:09.344] Build status: STARTED
[02:39:09.344] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:49:0) after 7m6s
[02:46:15.365] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:49:0)
[02:46:15.383] Build status: STARTED
[02:46:15.383] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:50:0) after 6m28s
[02:52:43.410] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:50:0)
[02:52:43.429] Build status: STARTED
[02:52:43.429] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:51:0) after 7m10s
[02:59:53.452] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:51:0)
[02:59:53.469] Build status: STARTED
[02:59:53.469] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:52:0) after 9m21s
[03:09:14.543] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:52:0)
[03:09:14.567] Build status: STARTED
[03:09:14.567] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:53:0) after 9m21s
[03:18:35.590] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:53:0)
[03:18:35.664] Build status: STARTED
[03:18:35.664] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:54:0) after 5m12s
[03:23:47.685] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:54:0)
[03:23:47.724] Build status: STARTED
[03:23:47.724] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:55:0) after 3m57s
[03:27:44.719] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:55:0)
[03:27:44.745] Build status: STARTED
[03:27:44.745] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:56:0) after 7m22s
[03:35:06.766] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:56:0)
[03:35:06.784] Build status: STARTED
[03:35:06.784] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:57:0) after 3m26s
[03:38:32.801] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:57:0)
[03:38:32.860] Build status: STARTED
[03:38:32.861] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:58:0) after 6m18s
[03:44:51.000] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:58:0)
[03:44:51.019] Build status: STARTED
[03:44:51.019] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:59:0) after 8m31s
[03:53:22.079] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:59:0)
[03:53:22.095] Build status: STARTED
[03:53:22.095] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:60:0) after 4m3s
[03:57:25.124] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:60:0)
[03:57:25.145] Build status: STARTED
[03:57:25.145] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:61:0) after 3m15s
[04:00:40.164] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:61:0)
[04:00:40.180] Build status: STARTED
[04:00:40.180] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:62:0) after 5m57s
[04:06:37.209] Handling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:62:0)
[04:06:37.235] Build status: STARTED
[04:06:37.235] Scheduling timer "check-buildbucket-build-status" (chromium-m139/linux-official:8873853644092050608:63:0) after 6m44s
[04:09:48.039] Received PubSub notification, asking Buildbucket for the build status
[04:09:48.067] Build:
{
"id": "8708423582220117393",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "linux-official"
},
"number": 139,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-24T22:45:15.458750134Z",
"startTime": "2025-07-24T22:45:19.634929200Z",
"endTime": "2025-07-25T04:09:47.743404978Z",
"updateTime": "2025-07-25T04:09:47.743404978Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "42fecc65efc0d096e5fb4e585339372041c9baf9",
"ref": "refs/branch-heads/7258"
}
}
}
[04:09:48.067] Invocation finished in 5h24m33.777759771s with status SUCCEEDED