[19:38:57.317] New invocation is queued and will start shortly
[19:38:58.440] Starting the invocation (attempt 1)
[19:38:58.467] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52f07e3d7e1166c186f3162657e9bfaeb736041e"
[19:38:58.467] Popped gitiles commit info from properties and tags
[19:38:58.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:38:58.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:38:58.469] Buildbucket request:
{
"requestId": "8874046557942285328",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874046557942285328",
"job": "chromium-m139/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "56785ed7f3eb275670e56635e335b500111e737e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@56785ed7f3eb275670e56635e335b500111e737e",
"title": "56785ed7f3eb275670e56635e335b500111e737e",
"url": "https://chromium.googlesource.com/chromium/src/+/56785ed7f3eb275670e56635e335b500111e737e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a1cf401954aaee8c6511296145b4d4cf2797ccf6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@a1cf401954aaee8c6511296145b4d4cf2797ccf6",
"title": "a1cf401954aaee8c6511296145b4d4cf2797ccf6",
"url": "https://chromium.googlesource.com/chromium/src/+/a1cf401954aaee8c6511296145b4d4cf2797ccf6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f658edd447a4bbf2ec2fe9baf356af7a95c92604"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@f658edd447a4bbf2ec2fe9baf356af7a95c92604",
"title": "f658edd447a4bbf2ec2fe9baf356af7a95c92604",
"url": "https://chromium.googlesource.com/chromium/src/+/f658edd447a4bbf2ec2fe9baf356af7a95c92604"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5857107613e0dd456b8b8410ca6e604bf71f5062"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@5857107613e0dd456b8b8410ca6e604bf71f5062",
"title": "5857107613e0dd456b8b8410ca6e604bf71f5062",
"url": "https://chromium.googlesource.com/chromium/src/+/5857107613e0dd456b8b8410ca6e604bf71f5062"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "92d55e6aa4bf2ea007812e61f21662667457a7a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@92d55e6aa4bf2ea007812e61f21662667457a7a2",
"title": "92d55e6aa4bf2ea007812e61f21662667457a7a2",
"url": "https://chromium.googlesource.com/chromium/src/+/92d55e6aa4bf2ea007812e61f21662667457a7a2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7258",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52f07e3d7e1166c186f3162657e9bfaeb736041e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7258@52f07e3d7e1166c186f3162657e9bfaeb736041e",
"title": "52f07e3d7e1166c186f3162657e9bfaeb736041e",
"url": "https://chromium.googlesource.com/chromium/src/+/52f07e3d7e1166c186f3162657e9bfaeb736041e"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52f07e3d7e1166c186f3162657e9bfaeb736041e",
"ref": "refs/branch-heads/7258"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874046557942285328"
},
{
"key": "scheduler_job_id",
"value": "chromium-m139/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:38:59.033] Scheduled build:
{
"id": "8708616496009531265",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 341,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-22T19:38:58.531478892Z",
"updateTime": "2025-07-22T19:38:58.531478892Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52f07e3d7e1166c186f3162657e9bfaeb736041e",
"ref": "refs/branch-heads/7258"
}
}
}
[19:38:59.033] Task URL: https://cr-buildbucket.appspot.com/build/8708616496009531265
[19:38:59.033] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:2:0) after 2m36s
[19:39:03.193] Received PubSub notification, asking Buildbucket for the build status
[19:39:03.219] Build status: SCHEDULED
[19:41:35.088] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:2:0)
[19:41:35.113] Build status: SCHEDULED
[19:41:35.113] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:4:0) after 3m39s
[19:45:14.160] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:4:0)
[19:45:14.186] Build status: SCHEDULED
[19:45:14.186] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:5:0) after 4m32s
[19:49:46.245] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:5:0)
[19:49:46.287] Build status: SCHEDULED
[19:49:46.287] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:6:0) after 3m30s
[19:53:16.351] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:6:0)
[19:53:16.382] Build status: SCHEDULED
[19:53:16.382] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:7:0) after 9m38s
[20:02:54.409] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:7:0)
[20:02:54.437] Build status: SCHEDULED
[20:02:54.437] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:8:0) after 2m3s
[20:04:57.493] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:8:0)
[20:04:57.518] Build status: SCHEDULED
[20:04:57.518] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:9:0) after 1m2s
[20:05:59.541] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:9:0)
[20:05:59.566] Build status: SCHEDULED
[20:05:59.566] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:10:0) after 8m49s
[20:14:48.637] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:10:0)
[20:14:48.730] Build status: SCHEDULED
[20:14:48.730] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:11:0) after 1m7s
[20:15:55.750] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:11:0)
[20:15:55.771] Build status: SCHEDULED
[20:15:55.771] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:12:0) after 5m16s
[20:18:49.135] Received PubSub notification, asking Buildbucket for the build status
[20:18:49.236] Build status: STARTED
[20:21:11.815] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:12:0)
[20:21:11.846] Build status: STARTED
[20:21:11.846] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:14:0) after 6m47s
[20:27:58.887] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:14:0)
[20:27:58.910] Build status: STARTED
[20:27:58.910] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:15:0) after 4m20s
[20:32:18.957] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:15:0)
[20:32:18.986] Build status: STARTED
[20:32:18.986] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:16:0) after 3m3s
[20:35:22.008] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:16:0)
[20:35:22.056] Build status: STARTED
[20:35:22.056] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:17:0) after 9m1s
[20:44:23.079] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:17:0)
[20:44:23.102] Build status: STARTED
[20:44:23.102] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:18:0) after 7m2s
[20:51:25.197] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:18:0)
[20:51:25.218] Build status: STARTED
[20:51:25.218] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:19:0) after 8m29s
[20:59:54.243] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:19:0)
[20:59:54.260] Build status: STARTED
[20:59:54.260] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:20:0) after 2m9s
[21:02:03.269] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:20:0)
[21:02:03.294] Build status: STARTED
[21:02:03.294] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:21:0) after 1m14s
[21:03:17.363] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:21:0)
[21:03:17.383] Build status: STARTED
[21:03:17.383] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:22:0) after 2m47s
[21:06:04.419] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:22:0)
[21:06:04.439] Build status: STARTED
[21:06:04.439] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:23:0) after 8m35s
[21:14:39.447] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:23:0)
[21:14:39.465] Build status: STARTED
[21:14:39.465] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:24:0) after 9m51s
[21:24:30.558] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:24:0)
[21:24:30.593] Build status: STARTED
[21:24:30.593] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:25:0) after 8m53s
[21:33:23.646] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:25:0)
[21:33:23.678] Build status: STARTED
[21:33:23.678] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:26:0) after 2m13s
[21:35:36.835] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:26:0)
[21:35:36.894] Build status: STARTED
[21:35:36.894] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:27:0) after 2m45s
[21:38:21.912] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:27:0)
[21:38:22.098] Build status: STARTED
[21:38:22.098] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:28:0) after 6m22s
[21:44:44.123] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:28:0)
[21:44:44.142] Build status: STARTED
[21:44:44.142] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:29:0) after 2m21s
[21:47:05.175] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:29:0)
[21:47:05.202] Build status: STARTED
[21:47:05.202] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:30:0) after 4m47s
[21:51:52.223] Handling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:30:0)
[21:51:52.253] Build status: STARTED
[21:51:52.253] Scheduling timer "check-buildbucket-build-status" (chromium-m139/Android x64 Builder All Targets (dbg):8874046557942285328:31:0) after 7m0s
[21:57:03.966] Received PubSub notification, asking Buildbucket for the build status
[21:57:04.009] Build:
{
"id": "8708616496009531265",
"builder": {
"project": "chromium-m139",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 341,
"createdBy": "project:chromium-m139",
"createTime": "2025-07-22T19:38:58.531478892Z",
"startTime": "2025-07-22T20:18:48.940445326Z",
"endTime": "2025-07-22T21:57:03.667047413Z",
"updateTime": "2025-07-22T21:57:03.667047413Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52f07e3d7e1166c186f3162657e9bfaeb736041e",
"ref": "refs/branch-heads/7258"
}
}
}
[21:57:04.009] Invocation finished in 2h18m6.703491178s with status SUCCEEDED