[09:01:12.290] New invocation is queued and will start shortly
[09:01:13.365] Starting the invocation (attempt 1)
[09:01:13.392] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/12de1f2e19e143fef7591a14c8b14569a79a93a5"
[09:01:13.392] Popped gitiles commit info from properties and tags
[09:01:13.392] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:01:13.392] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:01:13.392] Buildbucket request:
{
"requestId": "8896735923333217696",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896735923333217696",
"job": "chromium-m132/Android arm Builder (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e549f71ea8c902f6dbf18a868e1daa3c4bd536b3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@e549f71ea8c902f6dbf18a868e1daa3c4bd536b3",
"title": "e549f71ea8c902f6dbf18a868e1daa3c4bd536b3",
"url": "https://chromium.googlesource.com/chromium/src/+/e549f71ea8c902f6dbf18a868e1daa3c4bd536b3"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "642d3175669ee9bc55bb76eeda53c61f5c825dc7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@642d3175669ee9bc55bb76eeda53c61f5c825dc7",
"title": "642d3175669ee9bc55bb76eeda53c61f5c825dc7",
"url": "https://chromium.googlesource.com/chromium/src/+/642d3175669ee9bc55bb76eeda53c61f5c825dc7"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "36f4ea697e32561a90a8e0ab969ef0dfbb4897e7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@36f4ea697e32561a90a8e0ab969ef0dfbb4897e7",
"title": "36f4ea697e32561a90a8e0ab969ef0dfbb4897e7",
"url": "https://chromium.googlesource.com/chromium/src/+/36f4ea697e32561a90a8e0ab969ef0dfbb4897e7"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "64a4a3713331630d24ea98d569c61ba92d046ebc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@64a4a3713331630d24ea98d569c61ba92d046ebc",
"title": "64a4a3713331630d24ea98d569c61ba92d046ebc",
"url": "https://chromium.googlesource.com/chromium/src/+/64a4a3713331630d24ea98d569c61ba92d046ebc"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9dd8ffae6ea5a67a9dfd79c96edd5640d88e6a02"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@9dd8ffae6ea5a67a9dfd79c96edd5640d88e6a02",
"title": "9dd8ffae6ea5a67a9dfd79c96edd5640d88e6a02",
"url": "https://chromium.googlesource.com/chromium/src/+/9dd8ffae6ea5a67a9dfd79c96edd5640d88e6a02"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fb93918b6b77acde47b259b6825612e37ec36be2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@fb93918b6b77acde47b259b6825612e37ec36be2",
"title": "fb93918b6b77acde47b259b6825612e37ec36be2",
"url": "https://chromium.googlesource.com/chromium/src/+/fb93918b6b77acde47b259b6825612e37ec36be2"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "12de1f2e19e143fef7591a14c8b14569a79a93a5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@12de1f2e19e143fef7591a14c8b14569a79a93a5",
"title": "12de1f2e19e143fef7591a14c8b14569a79a93a5",
"url": "https://chromium.googlesource.com/chromium/src/+/12de1f2e19e143fef7591a14c8b14569a79a93a5"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12de1f2e19e143fef7591a14c8b14569a79a93a5",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896735923333217696"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/Android arm Builder (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:01:14.046] Scheduled build:
{
"id": "8731305861447764881",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"number": 16,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-14T09:01:13.457296341Z",
"updateTime": "2024-11-14T09:01:13.457296341Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12de1f2e19e143fef7591a14c8b14569a79a93a5",
"ref": "refs/branch-heads/6834"
}
}
}
[09:01:14.046] Task URL: https://cr-buildbucket.appspot.com/build/8731305861447764881
[09:01:14.046] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:2:0) after 8m44s
[09:01:23.303] Received PubSub notification, asking Buildbucket for the build status
[09:01:23.332] Build status: SCHEDULED
[09:09:58.498] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:2:0)
[09:09:58.525] Build status: SCHEDULED
[09:09:58.525] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:4:0) after 8m50s
[09:18:48.542] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:4:0)
[09:18:48.572] Build status: SCHEDULED
[09:18:48.572] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:5:0) after 4m49s
[09:23:37.598] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:5:0)
[09:23:37.643] Build status: SCHEDULED
[09:23:37.643] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:6:0) after 9m53s
[09:33:30.907] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:6:0)
[09:33:30.958] Build status: SCHEDULED
[09:33:30.958] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:7:0) after 5m34s
[09:39:05.117] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:7:0)
[09:39:05.150] Build status: SCHEDULED
[09:39:05.150] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:8:0) after 8m34s
[09:47:39.165] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:8:0)
[09:47:39.191] Build status: SCHEDULED
[09:47:39.191] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:9:0) after 2m31s
[09:50:10.207] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:9:0)
[09:50:10.243] Build status: SCHEDULED
[09:50:10.243] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:10:0) after 3m39s
[09:53:49.258] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:10:0)
[09:53:49.276] Build status: SCHEDULED
[09:53:49.276] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:11:0) after 2m48s
[09:56:37.404] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:11:0)
[09:56:37.440] Build status: SCHEDULED
[09:56:37.440] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:12:0) after 7m52s
[10:03:40.332] Received PubSub notification, asking Buildbucket for the build status
[10:03:40.348] Build status: STARTED
[10:04:29.706] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:12:0)
[10:04:29.727] Build status: STARTED
[10:04:29.727] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:14:0) after 4m23s
[10:08:52.762] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:14:0)
[10:08:52.818] Build status: STARTED
[10:08:52.818] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:15:0) after 2m5s
[10:10:57.833] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:15:0)
[10:10:57.857] Build status: STARTED
[10:10:57.857] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:16:0) after 3m8s
[10:14:05.886] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:16:0)
[10:14:05.907] Build status: STARTED
[10:14:05.907] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:17:0) after 9m21s
[10:23:27.020] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:17:0)
[10:23:27.043] Build status: STARTED
[10:23:27.043] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:18:0) after 3m30s
[10:26:57.141] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:18:0)
[10:26:57.299] Build status: STARTED
[10:26:57.299] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:19:0) after 3m26s
[10:30:23.315] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:19:0)
[10:30:23.335] Build status: STARTED
[10:30:23.335] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:20:0) after 1m45s
[10:32:08.468] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:20:0)
[10:32:08.492] Build status: STARTED
[10:32:08.492] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:21:0) after 5m39s
[10:37:47.508] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:21:0)
[10:37:47.526] Build status: STARTED
[10:37:47.526] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:22:0) after 4m7s
[10:41:54.505] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:22:0)
[10:41:54.583] Build status: STARTED
[10:41:54.583] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:23:0) after 1m4s
[10:42:58.600] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:23:0)
[10:42:58.620] Build status: STARTED
[10:42:58.620] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:24:0) after 1m32s
[10:44:30.641] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:24:0)
[10:44:31.106] Build status: STARTED
[10:44:31.106] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:25:0) after 4m21s
[10:48:52.123] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:25:0)
[10:48:52.155] Build status: STARTED
[10:48:52.155] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:26:0) after 3m31s
[10:52:23.244] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:26:0)
[10:52:23.259] Build status: STARTED
[10:52:23.259] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:27:0) after 8m38s
[11:01:01.256] Handling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:27:0)
[11:01:01.344] Build status: STARTED
[11:01:01.344] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android arm Builder (dbg):8896735923333217696:28:0) after 8m24s
[11:06:26.563] Received PubSub notification, asking Buildbucket for the build status
[11:06:26.589] Build:
{
"id": "8731305861447764881",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"number": 16,
"createdBy": "project:chromium-m132",
"createTime": "2024-11-14T09:01:13.457296341Z",
"startTime": "2024-11-14T10:03:39.500732339Z",
"endTime": "2024-11-14T11:06:26.153294676Z",
"updateTime": "2024-11-14T11:06:26.153294676Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "12de1f2e19e143fef7591a14c8b14569a79a93a5",
"ref": "refs/branch-heads/6834"
}
}
}
[11:06:26.589] Invocation finished in 2h5m14.312548415s with status SUCCEEDED