[19:25:56.090] New invocation is queued and will start shortly
[19:25:57.143] Starting the invocation (attempt 1)
[19:25:57.169] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/777ddb9a8fa05e0a515f354f96b013e40424ddea"
[19:25:57.169] Popped gitiles commit info from properties and tags
[19:25:57.169] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:25:57.170] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:25:57.171] Buildbucket request:
{
"requestId": "8893888112760738064",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893888112760738064",
"job": "chromium-m132/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1e01f98d45a1979eb8b76c897149ffd455009afd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@1e01f98d45a1979eb8b76c897149ffd455009afd",
"title": "1e01f98d45a1979eb8b76c897149ffd455009afd",
"url": "https://chromium.googlesource.com/chromium/src/+/1e01f98d45a1979eb8b76c897149ffd455009afd"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2b8194e907fdb4664d4cb26c905ff353db6b4fae"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@2b8194e907fdb4664d4cb26c905ff353db6b4fae",
"title": "2b8194e907fdb4664d4cb26c905ff353db6b4fae",
"url": "https://chromium.googlesource.com/chromium/src/+/2b8194e907fdb4664d4cb26c905ff353db6b4fae"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f491e5b0ae89f8d260b6523f454f2d6c8f6ed668"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@f491e5b0ae89f8d260b6523f454f2d6c8f6ed668",
"title": "f491e5b0ae89f8d260b6523f454f2d6c8f6ed668",
"url": "https://chromium.googlesource.com/chromium/src/+/f491e5b0ae89f8d260b6523f454f2d6c8f6ed668"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2d236685803f478419a0d9e1392b90dc5a788b9f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@2d236685803f478419a0d9e1392b90dc5a788b9f",
"title": "2d236685803f478419a0d9e1392b90dc5a788b9f",
"url": "https://chromium.googlesource.com/chromium/src/+/2d236685803f478419a0d9e1392b90dc5a788b9f"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ed00382b3b20cc6105ab1bd5d381adf115554ad0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@ed00382b3b20cc6105ab1bd5d381adf115554ad0",
"title": "ed00382b3b20cc6105ab1bd5d381adf115554ad0",
"url": "https://chromium.googlesource.com/chromium/src/+/ed00382b3b20cc6105ab1bd5d381adf115554ad0"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "777ddb9a8fa05e0a515f354f96b013e40424ddea"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@777ddb9a8fa05e0a515f354f96b013e40424ddea",
"title": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"url": "https://chromium.googlesource.com/chromium/src/+/777ddb9a8fa05e0a515f354f96b013e40424ddea"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893888112760738064"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/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:25:57.775] Scheduled build:
{
"id": "8728458050888003489",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 180,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-15T19:25:57.246291900Z",
"updateTime": "2024-12-15T19:25:57.246291900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
}
}
}
[19:25:57.775] Task URL: https://cr-buildbucket.appspot.com/build/8728458050888003489
[19:25:57.775] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:2:0) after 6m1s
[19:25:58.713] Received PubSub notification, asking Buildbucket for the build status
[19:25:58.733] Build status: SCHEDULED
[19:31:58.906] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:2:0)
[19:31:58.926] Build status: SCHEDULED
[19:31:58.926] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:4:0) after 6m17s
[19:38:15.942] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:4:0)
[19:38:15.962] Build status: SCHEDULED
[19:38:15.962] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:5:0) after 7m5s
[19:45:20.976] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:5:0)
[19:45:21.004] Build status: SCHEDULED
[19:45:21.004] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:6:0) after 4m46s
[19:50:07.025] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:6:0)
[19:50:07.057] Build status: SCHEDULED
[19:50:07.057] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:7:0) after 9m41s
[19:59:48.172] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:7:0)
[19:59:48.194] Build status: SCHEDULED
[19:59:48.194] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:8:0) after 6m23s
[20:06:11.206] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:8:0)
[20:06:11.225] Build status: SCHEDULED
[20:06:11.225] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:9:0) after 8m23s
[20:14:34.496] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:9:0)
[20:14:34.519] Build status: SCHEDULED
[20:14:34.519] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:10:0) after 2m51s
[20:17:25.534] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:10:0)
[20:17:25.572] Build status: SCHEDULED
[20:17:25.572] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:11:0) after 6m45s
[20:24:11.049] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:11:0)
[20:24:11.067] Build status: SCHEDULED
[20:24:11.068] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:12:0) after 6m2s
[20:30:13.264] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:12:0)
[20:30:13.282] Build status: SCHEDULED
[20:30:13.282] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:13:0) after 9m13s
[20:39:26.429] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:13:0)
[20:39:26.447] Build status: SCHEDULED
[20:39:26.447] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:14:0) after 1m32s
[20:40:58.532] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:14:0)
[20:40:58.570] Build status: SCHEDULED
[20:40:58.570] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:15:0) after 5m41s
[20:45:12.066] Received PubSub notification, asking Buildbucket for the build status
[20:45:12.092] Build status: STARTED
[20:46:39.703] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:15:0)
[20:46:39.781] Build status: STARTED
[20:46:39.781] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:17:0) after 6m9s
[20:52:48.851] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:17:0)
[20:52:48.896] Build status: STARTED
[20:52:48.897] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:18:0) after 3m39s
[20:56:28.021] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:18:0)
[20:56:28.048] Build status: STARTED
[20:56:28.048] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:19:0) after 3m1s
[20:59:29.063] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:19:0)
[20:59:29.089] Build status: STARTED
[20:59:29.089] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:20:0) after 4m4s
[21:03:33.104] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:20:0)
[21:03:33.184] Build status: STARTED
[21:03:33.184] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:21:0) after 3m49s
[21:07:22.200] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:21:0)
[21:07:22.227] Build status: STARTED
[21:07:22.227] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:22:0) after 1m6s
[21:08:28.242] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:22:0)
[21:08:28.257] Build status: STARTED
[21:08:28.257] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:23:0) after 3m31s
[21:11:59.228] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:23:0)
[21:11:59.246] Build status: STARTED
[21:11:59.246] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:24:0) after 9m50s
[21:21:49.261] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:24:0)
[21:21:49.279] Build status: STARTED
[21:21:49.279] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:25:0) after 9m39s
[21:31:28.295] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:25:0)
[21:31:28.462] Build status: STARTED
[21:31:28.462] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:26:0) after 3m16s
[21:34:44.561] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:26:0)
[21:34:44.580] Build status: STARTED
[21:34:44.580] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:27:0) after 1m49s
[21:36:33.596] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:27:0)
[21:36:33.616] Build status: STARTED
[21:36:33.616] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:28:0) after 4m8s
[21:40:41.633] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:28:0)
[21:40:41.658] Build status: STARTED
[21:40:41.658] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:29:0) after 4m24s
[21:45:05.676] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:29:0)
[21:45:05.697] Build status: STARTED
[21:45:05.697] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:30:0) after 9m34s
[21:54:39.713] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:30:0)
[21:54:39.729] Build status: STARTED
[21:54:39.730] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:31:0) after 5m57s
[22:00:36.969] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:31:0)
[22:00:36.986] Build status: STARTED
[22:00:36.986] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:32:0) after 7m55s
[22:08:32.034] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:32:0)
[22:08:32.055] Build status: STARTED
[22:08:32.055] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:33:0) after 8m59s
[22:17:31.076] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:33:0)
[22:17:31.094] Build status: STARTED
[22:17:31.094] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:34:0) after 5m6s
[22:22:37.111] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:34:0)
[22:22:37.134] Build status: STARTED
[22:22:37.134] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:35:0) after 4m39s
[22:27:16.308] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:35:0)
[22:27:16.365] Build status: STARTED
[22:27:16.365] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:36:0) after 7m12s
[22:34:28.464] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:36:0)
[22:34:28.535] Build status: STARTED
[22:34:28.535] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:37:0) after 7m33s
[22:42:01.551] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:37:0)
[22:42:01.567] Build status: STARTED
[22:42:01.567] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:38:0) after 4m53s
[22:46:54.662] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:38:0)
[22:46:54.679] Build status: STARTED
[22:46:54.679] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:39:0) after 5m13s
[22:52:07.676] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:39:0)
[22:52:07.692] Build status: STARTED
[22:52:07.692] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:40:0) after 6m11s
[22:58:18.966] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:40:0)
[22:58:18.982] Build status: STARTED
[22:58:18.982] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:41:0) after 1m2s
[22:59:21.002] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:41:0)
[22:59:21.019] Build status: STARTED
[22:59:21.019] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:42:0) after 9m27s
[23:08:48.188] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:42:0)
[23:08:48.204] Build status: STARTED
[23:08:48.204] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:43:0) after 6m13s
[23:15:01.328] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:43:0)
[23:15:01.346] Build status: STARTED
[23:15:01.346] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:44:0) after 2m56s
[23:17:57.362] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:44:0)
[23:17:57.556] Build status: STARTED
[23:17:57.556] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8893888112760738064:45:0) after 5m2s
[23:22:28.796] Received PubSub notification, asking Buildbucket for the build status
[23:22:28.813] Build:
{
"id": "8728458050888003489",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 180,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-15T19:25:57.246291900Z",
"startTime": "2024-12-15T20:44:53.050045925Z",
"endTime": "2024-12-15T23:22:28.012255174Z",
"updateTime": "2024-12-15T23:22:28.012255174Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "777ddb9a8fa05e0a515f354f96b013e40424ddea",
"ref": "refs/branch-heads/6834"
}
}
}
[23:22:28.813] Invocation finished in 3h56m32.736531609s with status SUCCEEDED