[04:39:02.520] New invocation is queued and will start shortly
[04:39:03.616] Starting the invocation (attempt 1)
[04:39:03.643] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f8186f0dc9669aee7f7d634d426481d903ac6d00"
[04:39:03.643] Popped gitiles commit info from properties and tags
[04:39:03.644] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:39:03.644] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:39:03.644] Buildbucket request:
{
"requestId": "8878542426945158336",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "linux-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8878542426945158336",
"job": "chromium-m138/linux-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "11aab6b383238b5cc4de0448d549bb32a065488e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@11aab6b383238b5cc4de0448d549bb32a065488e",
"title": "11aab6b383238b5cc4de0448d549bb32a065488e",
"url": "https://chromium.googlesource.com/chromium/src/+/11aab6b383238b5cc4de0448d549bb32a065488e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "14fdb505f5ef1950e51b4c5a6edacd6512d36b2f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@14fdb505f5ef1950e51b4c5a6edacd6512d36b2f",
"title": "14fdb505f5ef1950e51b4c5a6edacd6512d36b2f",
"url": "https://chromium.googlesource.com/chromium/src/+/14fdb505f5ef1950e51b4c5a6edacd6512d36b2f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "eaa0d8966342908d3674c778bd9a6b8c3f0ce89e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@eaa0d8966342908d3674c778bd9a6b8c3f0ce89e",
"title": "eaa0d8966342908d3674c778bd9a6b8c3f0ce89e",
"url": "https://chromium.googlesource.com/chromium/src/+/eaa0d8966342908d3674c778bd9a6b8c3f0ce89e"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e4dbcefe9a719fc37fb402f8ec728edf5468fd26"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@e4dbcefe9a719fc37fb402f8ec728edf5468fd26",
"title": "e4dbcefe9a719fc37fb402f8ec728edf5468fd26",
"url": "https://chromium.googlesource.com/chromium/src/+/e4dbcefe9a719fc37fb402f8ec728edf5468fd26"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e81b60c1dc063850b28a8c73cca2c808a3a55d23"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@e81b60c1dc063850b28a8c73cca2c808a3a55d23",
"title": "e81b60c1dc063850b28a8c73cca2c808a3a55d23",
"url": "https://chromium.googlesource.com/chromium/src/+/e81b60c1dc063850b28a8c73cca2c808a3a55d23"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0937fc9c074e17527c471441d92c9733862ebd3a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@0937fc9c074e17527c471441d92c9733862ebd3a",
"title": "0937fc9c074e17527c471441d92c9733862ebd3a",
"url": "https://chromium.googlesource.com/chromium/src/+/0937fc9c074e17527c471441d92c9733862ebd3a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "47c12332a9c4eba5909ab8d62d6b79d5b60a1b84"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@47c12332a9c4eba5909ab8d62d6b79d5b60a1b84",
"title": "47c12332a9c4eba5909ab8d62d6b79d5b60a1b84",
"url": "https://chromium.googlesource.com/chromium/src/+/47c12332a9c4eba5909ab8d62d6b79d5b60a1b84"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ae8c12c7cc0e7fb73548bd8c81ad3f794bb1163c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@ae8c12c7cc0e7fb73548bd8c81ad3f794bb1163c",
"title": "ae8c12c7cc0e7fb73548bd8c81ad3f794bb1163c",
"url": "https://chromium.googlesource.com/chromium/src/+/ae8c12c7cc0e7fb73548bd8c81ad3f794bb1163c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0e6ac3e021c2de1a0c087b2d9bbe1d14f70a49a4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@0e6ac3e021c2de1a0c087b2d9bbe1d14f70a49a4",
"title": "0e6ac3e021c2de1a0c087b2d9bbe1d14f70a49a4",
"url": "https://chromium.googlesource.com/chromium/src/+/0e6ac3e021c2de1a0c087b2d9bbe1d14f70a49a4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "82c70d2e94360925ed8d54e37761929bda1c57c4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@82c70d2e94360925ed8d54e37761929bda1c57c4",
"title": "82c70d2e94360925ed8d54e37761929bda1c57c4",
"url": "https://chromium.googlesource.com/chromium/src/+/82c70d2e94360925ed8d54e37761929bda1c57c4"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "efab7129020d21a5e26d58c43bd1c7bb34a3a9bf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@efab7129020d21a5e26d58c43bd1c7bb34a3a9bf",
"title": "efab7129020d21a5e26d58c43bd1c7bb34a3a9bf",
"url": "https://chromium.googlesource.com/chromium/src/+/efab7129020d21a5e26d58c43bd1c7bb34a3a9bf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "25e7da166c46dbcf554171ed37dfa7df3e099199"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@25e7da166c46dbcf554171ed37dfa7df3e099199",
"title": "25e7da166c46dbcf554171ed37dfa7df3e099199",
"url": "https://chromium.googlesource.com/chromium/src/+/25e7da166c46dbcf554171ed37dfa7df3e099199"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2de045743b4a5ca728fa33619ab9f47436460082"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@2de045743b4a5ca728fa33619ab9f47436460082",
"title": "2de045743b4a5ca728fa33619ab9f47436460082",
"url": "https://chromium.googlesource.com/chromium/src/+/2de045743b4a5ca728fa33619ab9f47436460082"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "053ee00fab7380d51984134c04f02e8f6d967669"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@053ee00fab7380d51984134c04f02e8f6d967669",
"title": "053ee00fab7380d51984134c04f02e8f6d967669",
"url": "https://chromium.googlesource.com/chromium/src/+/053ee00fab7380d51984134c04f02e8f6d967669"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0bb958ccc5038480c5757ac85eb5f6f38216ac58"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@0bb958ccc5038480c5757ac85eb5f6f38216ac58",
"title": "0bb958ccc5038480c5757ac85eb5f6f38216ac58",
"url": "https://chromium.googlesource.com/chromium/src/+/0bb958ccc5038480c5757ac85eb5f6f38216ac58"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8e279eee70ea96470bb859fa77743d45a7fcc2c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@8e279eee70ea96470bb859fa77743d45a7fcc2c9",
"title": "8e279eee70ea96470bb859fa77743d45a7fcc2c9",
"url": "https://chromium.googlesource.com/chromium/src/+/8e279eee70ea96470bb859fa77743d45a7fcc2c9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7204",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f8186f0dc9669aee7f7d634d426481d903ac6d00"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7204@f8186f0dc9669aee7f7d634d426481d903ac6d00",
"title": "f8186f0dc9669aee7f7d634d426481d903ac6d00",
"url": "https://chromium.googlesource.com/chromium/src/+/f8186f0dc9669aee7f7d634d426481d903ac6d00"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8186f0dc9669aee7f7d634d426481d903ac6d00",
"ref": "refs/branch-heads/7204"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878542426945158336"
},
{
"key": "scheduler_job_id",
"value": "chromium-m138/linux-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:39:04.184] Scheduled build:
{
"id": "8713112365021446801",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "linux-official"
},
"number": 30,
"createdBy": "project:chromium-m138",
"createTime": "2025-06-03T04:39:03.725604763Z",
"updateTime": "2025-06-03T04:39:03.725604763Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8186f0dc9669aee7f7d634d426481d903ac6d00",
"ref": "refs/branch-heads/7204"
}
}
}
[04:39:04.184] Task URL: https://cr-buildbucket.appspot.com/build/8713112365021446801
[04:39:04.184] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:2:0) after 6m19s
[04:39:05.189] Received PubSub notification, asking Buildbucket for the build status
[04:39:05.214] Build status: SCHEDULED
[04:40:50.991] Received PubSub notification, asking Buildbucket for the build status
[04:40:51.016] Build status: STARTED
[04:45:23.191] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:2:0)
[04:45:23.222] Build status: STARTED
[04:45:23.222] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:5:0) after 3m17s
[04:48:40.314] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:5:0)
[04:48:40.334] Build status: STARTED
[04:48:40.334] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:6:0) after 7m7s
[04:55:47.355] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:6:0)
[04:55:47.383] Build status: STARTED
[04:55:47.383] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:7:0) after 3m4s
[04:58:51.405] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:7:0)
[04:58:51.492] Build status: STARTED
[04:58:51.492] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:8:0) after 4m38s
[05:03:29.522] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:8:0)
[05:03:29.573] Build status: STARTED
[05:03:29.573] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:9:0) after 3m40s
[05:07:09.587] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:9:0)
[05:07:09.605] Build status: STARTED
[05:07:09.605] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:10:0) after 4m36s
[05:11:45.631] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:10:0)
[05:11:45.655] Build status: STARTED
[05:11:45.655] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:11:0) after 6m49s
[05:18:34.673] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:11:0)
[05:18:34.694] Build status: STARTED
[05:18:34.695] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:12:0) after 6m28s
[05:25:02.725] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:12:0)
[05:25:02.785] Build status: STARTED
[05:25:02.785] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:13:0) after 9m13s
[05:34:15.852] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:13:0)
[05:34:15.878] Build status: STARTED
[05:34:15.878] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:14:0) after 2m12s
[05:36:27.952] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:14:0)
[05:36:27.988] Build status: STARTED
[05:36:27.988] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:15:0) after 4m5s
[05:40:33.138] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:15:0)
[05:40:33.167] Build status: STARTED
[05:40:33.167] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:16:0) after 9m33s
[05:50:06.434] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:16:0)
[05:50:06.457] Build status: STARTED
[05:50:06.457] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:17:0) after 9m32s
[05:59:38.660] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:17:0)
[05:59:38.707] Build status: STARTED
[05:59:38.707] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:18:0) after 5m46s
[06:05:24.906] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:18:0)
[06:05:24.926] Build status: STARTED
[06:05:24.926] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:19:0) after 6m1s
[06:11:26.039] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:19:0)
[06:11:26.061] Build status: STARTED
[06:11:26.061] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:20:0) after 5m4s
[06:16:30.077] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:20:0)
[06:16:30.101] Build status: STARTED
[06:16:30.101] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:21:0) after 1m29s
[06:17:59.128] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:21:0)
[06:17:59.174] Build status: STARTED
[06:17:59.174] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:22:0) after 4m33s
[06:22:32.269] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:22:0)
[06:22:32.284] Build status: STARTED
[06:22:32.284] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:23:0) after 6m22s
[06:28:54.309] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:23:0)
[06:28:54.334] Build status: STARTED
[06:28:54.334] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:24:0) after 5m43s
[06:34:37.356] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:24:0)
[06:34:37.382] Build status: STARTED
[06:34:37.382] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:25:0) after 6m24s
[06:41:01.375] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:25:0)
[06:41:01.443] Build status: STARTED
[06:41:01.443] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:26:0) after 5m30s
[06:46:31.460] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:26:0)
[06:46:31.478] Build status: STARTED
[06:46:31.479] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:27:0) after 4m57s
[06:51:28.553] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:27:0)
[06:51:28.578] Build status: STARTED
[06:51:28.578] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:28:0) after 2m30s
[06:53:58.603] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:28:0)
[06:53:58.637] Build status: STARTED
[06:53:58.637] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:29:0) after 9m43s
[07:03:41.711] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:29:0)
[07:03:41.821] Build status: STARTED
[07:03:41.821] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:30:0) after 5m43s
[07:09:24.882] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:30:0)
[07:09:24.904] Build status: STARTED
[07:09:24.904] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:31:0) after 5m44s
[07:15:08.924] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:31:0)
[07:15:08.947] Build status: STARTED
[07:15:08.947] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:32:0) after 8m4s
[07:23:13.037] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:32:0)
[07:23:13.054] Build status: STARTED
[07:23:13.054] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:33:0) after 3m4s
[07:26:17.128] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:33:0)
[07:26:17.204] Build status: STARTED
[07:26:17.204] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:34:0) after 8m21s
[07:34:38.228] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:34:0)
[07:34:38.256] Build status: STARTED
[07:34:38.256] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:35:0) after 5m44s
[07:40:22.260] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:35:0)
[07:40:22.276] Build status: STARTED
[07:40:22.276] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:36:0) after 1m39s
[07:42:01.366] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:36:0)
[07:42:01.388] Build status: STARTED
[07:42:01.388] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:37:0) after 1m23s
[07:43:24.411] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:37:0)
[07:43:24.432] Build status: STARTED
[07:43:24.433] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:38:0) after 8m46s
[07:52:10.477] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:38:0)
[07:52:10.652] Build status: STARTED
[07:52:10.652] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:39:0) after 3m31s
[07:55:41.672] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:39:0)
[07:55:41.689] Build status: STARTED
[07:55:41.689] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:40:0) after 4m28s
[08:00:09.734] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:40:0)
[08:00:09.761] Build status: STARTED
[08:00:09.761] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:41:0) after 3m27s
[08:03:36.777] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:41:0)
[08:03:36.795] Build status: STARTED
[08:03:36.795] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:42:0) after 4m59s
[08:08:35.812] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:42:0)
[08:08:35.857] Build status: STARTED
[08:08:35.857] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:43:0) after 5m29s
[08:14:04.885] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:43:0)
[08:14:04.907] Build status: STARTED
[08:14:04.907] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:44:0) after 6m25s
[08:20:29.926] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:44:0)
[08:20:29.955] Build status: STARTED
[08:20:29.955] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:45:0) after 8m43s
[08:29:13.028] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:45:0)
[08:29:13.074] Build status: STARTED
[08:29:13.074] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:46:0) after 4m20s
[08:33:33.097] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:46:0)
[08:33:33.131] Build status: STARTED
[08:33:33.131] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:47:0) after 4m34s
[08:38:07.161] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:47:0)
[08:38:07.181] Build status: STARTED
[08:38:07.181] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:48:0) after 2m45s
[08:40:52.188] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:48:0)
[08:40:52.205] Build status: STARTED
[08:40:52.205] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:49:0) after 1m32s
[08:42:24.226] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:49:0)
[08:42:24.244] Build status: STARTED
[08:42:24.244] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:50:0) after 2m51s
[08:45:15.242] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:50:0)
[08:45:15.258] Build status: STARTED
[08:45:15.258] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:51:0) after 7m35s
[08:52:50.294] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:51:0)
[08:52:50.313] Build status: STARTED
[08:52:50.313] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:52:0) after 1m51s
[08:54:41.289] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:52:0)
[08:54:41.314] Build status: STARTED
[08:54:41.314] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:53:0) after 4m54s
[08:59:35.386] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:53:0)
[08:59:35.407] Build status: STARTED
[08:59:35.407] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:54:0) after 9m53s
[09:09:28.431] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:54:0)
[09:09:28.450] Build status: STARTED
[09:09:28.450] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:55:0) after 7m6s
[09:16:34.452] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:55:0)
[09:16:34.467] Build status: STARTED
[09:16:34.467] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:56:0) after 2m56s
[09:19:30.540] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:56:0)
[09:19:30.567] Build status: STARTED
[09:19:30.567] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:57:0) after 2m27s
[09:21:57.674] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:57:0)
[09:21:57.720] Build status: STARTED
[09:21:57.720] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:58:0) after 9m45s
[09:31:42.798] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:58:0)
[09:31:42.818] Build status: STARTED
[09:31:42.818] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:59:0) after 9m46s
[09:41:28.933] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:59:0)
[09:41:28.954] Build status: STARTED
[09:41:28.954] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:60:0) after 9m57s
[09:51:26.039] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:60:0)
[09:51:26.055] Build status: STARTED
[09:51:26.055] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:61:0) after 6m40s
[09:58:06.080] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:61:0)
[09:58:06.096] Build status: STARTED
[09:58:06.096] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:62:0) after 2m3s
[10:00:09.117] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:62:0)
[10:00:09.141] Build status: STARTED
[10:00:09.141] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:63:0) after 7m48s
[10:07:57.211] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:63:0)
[10:07:57.273] Build status: STARTED
[10:07:57.273] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:64:0) after 5m4s
[10:13:01.298] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:64:0)
[10:13:01.328] Build status: STARTED
[10:13:01.328] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:65:0) after 4m11s
[10:17:12.781] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:65:0)
[10:17:12.819] Build status: STARTED
[10:17:12.819] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:66:0) after 8m29s
[10:25:41.897] Handling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:66:0)
[10:25:41.915] Build status: STARTED
[10:25:41.915] Scheduling timer "check-buildbucket-build-status" (chromium-m138/linux-official:8878542426945158336:67:0) after 3m41s
[10:26:20.057] Received PubSub notification, asking Buildbucket for the build status
[10:26:20.180] Build:
{
"id": "8713112365021446801",
"builder": {
"project": "chromium-m138",
"bucket": "ci",
"builder": "linux-official"
},
"number": 30,
"createdBy": "project:chromium-m138",
"createTime": "2025-06-03T04:39:03.725604763Z",
"startTime": "2025-06-03T04:40:50.795845953Z",
"endTime": "2025-06-03T10:26:18.973827920Z",
"updateTime": "2025-06-03T10:26:18.973827920Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f8186f0dc9669aee7f7d634d426481d903ac6d00",
"ref": "refs/branch-heads/7204"
}
}
}
[10:26:20.180] Invocation finished in 5h47m17.673668363s with status SUCCEEDED