[20:57:58.626] New invocation is queued and will start shortly
[20:57:59.957] Starting the invocation (attempt 1)
[20:57:59.992] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48088418e1e8cadf995109648677731cb2a6e097"
[20:57:59.992] Popped gitiles commit info from properties and tags
[20:57:59.992] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:59.992] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:59.993] Buildbucket request:
{
"requestId": "8901401870174034560",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901401870174034560",
"job": "chromium-m130/Android arm Builder (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4951f9b5a67ce6150b820195a3829bd6afd619f8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@4951f9b5a67ce6150b820195a3829bd6afd619f8",
"title": "4951f9b5a67ce6150b820195a3829bd6afd619f8",
"url": "https://chromium.googlesource.com/chromium/src/+/4951f9b5a67ce6150b820195a3829bd6afd619f8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "581997f879df01a9f14f521449fd184e195620e8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@581997f879df01a9f14f521449fd184e195620e8",
"title": "581997f879df01a9f14f521449fd184e195620e8",
"url": "https://chromium.googlesource.com/chromium/src/+/581997f879df01a9f14f521449fd184e195620e8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "843350798a7ea125c78fbda5bbd83938390e53a9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@843350798a7ea125c78fbda5bbd83938390e53a9",
"title": "843350798a7ea125c78fbda5bbd83938390e53a9",
"url": "https://chromium.googlesource.com/chromium/src/+/843350798a7ea125c78fbda5bbd83938390e53a9"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b18b3780657b6e5eaf688e7cc233222609b1c248"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@b18b3780657b6e5eaf688e7cc233222609b1c248",
"title": "b18b3780657b6e5eaf688e7cc233222609b1c248",
"url": "https://chromium.googlesource.com/chromium/src/+/b18b3780657b6e5eaf688e7cc233222609b1c248"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "58a70d064fc4dddb52a0e3f90d2e025aa339f805"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@58a70d064fc4dddb52a0e3f90d2e025aa339f805",
"title": "58a70d064fc4dddb52a0e3f90d2e025aa339f805",
"url": "https://chromium.googlesource.com/chromium/src/+/58a70d064fc4dddb52a0e3f90d2e025aa339f805"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d00eecaaae7373c3d11824e19c6602f52382adf4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@d00eecaaae7373c3d11824e19c6602f52382adf4",
"title": "d00eecaaae7373c3d11824e19c6602f52382adf4",
"url": "https://chromium.googlesource.com/chromium/src/+/d00eecaaae7373c3d11824e19c6602f52382adf4"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0f1130b654f035f29250674e1fc98f401ac4a1e0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@0f1130b654f035f29250674e1fc98f401ac4a1e0",
"title": "0f1130b654f035f29250674e1fc98f401ac4a1e0",
"url": "https://chromium.googlesource.com/chromium/src/+/0f1130b654f035f29250674e1fc98f401ac4a1e0"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9902617b8bf31396836dd31f9e19c9efa3556656"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@9902617b8bf31396836dd31f9e19c9efa3556656",
"title": "9902617b8bf31396836dd31f9e19c9efa3556656",
"url": "https://chromium.googlesource.com/chromium/src/+/9902617b8bf31396836dd31f9e19c9efa3556656"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "43579fd287da48f98c0204388c9d5a4e208ee126"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@43579fd287da48f98c0204388c9d5a4e208ee126",
"title": "43579fd287da48f98c0204388c9d5a4e208ee126",
"url": "https://chromium.googlesource.com/chromium/src/+/43579fd287da48f98c0204388c9d5a4e208ee126"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6074de56224378eac8d847333f95c0e1d79b2077"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@6074de56224378eac8d847333f95c0e1d79b2077",
"title": "6074de56224378eac8d847333f95c0e1d79b2077",
"url": "https://chromium.googlesource.com/chromium/src/+/6074de56224378eac8d847333f95c0e1d79b2077"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "de8accfb38f2a7e0b47aa1330eda059d3f90bb89"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@de8accfb38f2a7e0b47aa1330eda059d3f90bb89",
"title": "de8accfb38f2a7e0b47aa1330eda059d3f90bb89",
"url": "https://chromium.googlesource.com/chromium/src/+/de8accfb38f2a7e0b47aa1330eda059d3f90bb89"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e140a6540cfe775e26d263167795e9067c2cb43f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@e140a6540cfe775e26d263167795e9067c2cb43f",
"title": "e140a6540cfe775e26d263167795e9067c2cb43f",
"url": "https://chromium.googlesource.com/chromium/src/+/e140a6540cfe775e26d263167795e9067c2cb43f"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "797a2e0fd1b9b9cb3560ca2fac71ec2711bfe94d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@797a2e0fd1b9b9cb3560ca2fac71ec2711bfe94d",
"title": "797a2e0fd1b9b9cb3560ca2fac71ec2711bfe94d",
"url": "https://chromium.googlesource.com/chromium/src/+/797a2e0fd1b9b9cb3560ca2fac71ec2711bfe94d"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d53b9c59b2ef0a747cf0cb6cf97fd02887fa3a1c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@d53b9c59b2ef0a747cf0cb6cf97fd02887fa3a1c",
"title": "d53b9c59b2ef0a747cf0cb6cf97fd02887fa3a1c",
"url": "https://chromium.googlesource.com/chromium/src/+/d53b9c59b2ef0a747cf0cb6cf97fd02887fa3a1c"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a41258cb2df63ecad4ae15eeae35db9f60eb50ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@a41258cb2df63ecad4ae15eeae35db9f60eb50ab",
"title": "a41258cb2df63ecad4ae15eeae35db9f60eb50ab",
"url": "https://chromium.googlesource.com/chromium/src/+/a41258cb2df63ecad4ae15eeae35db9f60eb50ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/6723",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "48088418e1e8cadf995109648677731cb2a6e097"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6723@48088418e1e8cadf995109648677731cb2a6e097",
"title": "48088418e1e8cadf995109648677731cb2a6e097",
"url": "https://chromium.googlesource.com/chromium/src/+/48088418e1e8cadf995109648677731cb2a6e097"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "48088418e1e8cadf995109648677731cb2a6e097",
"ref": "refs/branch-heads/6723"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901401870174034560"
},
{
"key": "scheduler_job_id",
"value": "chromium-m130/Android arm Builder (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:58:00.617] Scheduled build:
{
"id": "8735971808003418017",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"number": 62,
"createdBy": "project:chromium-m130",
"createTime": "2024-09-23T20:58:00.066699898Z",
"updateTime": "2024-09-23T20:58:00.066699898Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "48088418e1e8cadf995109648677731cb2a6e097",
"ref": "refs/branch-heads/6723"
}
}
}
[20:58:00.617] Task URL: https://cr-buildbucket.appspot.com/build/8735971808003418017
[20:58:00.617] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:2:0) after 6m30s
[20:58:01.536] Received PubSub notification, asking Buildbucket for the build status
[20:58:01.557] Build status: SCHEDULED
[21:04:30.684] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:2:0)
[21:04:30.717] Build status: SCHEDULED
[21:04:30.717] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:4:0) after 6m21s
[21:10:51.753] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:4:0)
[21:10:51.772] Build status: SCHEDULED
[21:10:51.772] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:5:0) after 8m11s
[21:19:02.840] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:5:0)
[21:19:02.867] Build status: SCHEDULED
[21:19:02.867] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:6:0) after 5m37s
[21:24:39.887] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:6:0)
[21:24:39.909] Build status: SCHEDULED
[21:24:39.909] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:7:0) after 8m12s
[21:32:51.933] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:7:0)
[21:32:51.981] Build status: SCHEDULED
[21:32:51.981] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:8:0) after 3m38s
[21:36:30.048] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:8:0)
[21:36:30.066] Build status: SCHEDULED
[21:36:30.067] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:9:0) after 8m14s
[21:44:44.085] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:9:0)
[21:44:44.110] Build status: SCHEDULED
[21:44:44.110] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:10:0) after 3m28s
[21:48:12.128] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:10:0)
[21:48:12.145] Build status: SCHEDULED
[21:48:12.145] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:11:0) after 7m27s
[21:55:39.162] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:11:0)
[21:55:39.182] Build status: SCHEDULED
[21:55:39.182] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:12:0) after 8m39s
[22:04:18.210] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:12:0)
[22:04:18.235] Build status: SCHEDULED
[22:04:18.235] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:13:0) after 9m5s
[22:13:23.255] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:13:0)
[22:13:23.276] Build status: SCHEDULED
[22:13:23.276] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:14:0) after 5m4s
[22:18:27.294] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:14:0)
[22:18:27.311] Build status: SCHEDULED
[22:18:27.311] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:15:0) after 6m38s
[22:25:05.393] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:15:0)
[22:25:05.411] Build status: SCHEDULED
[22:25:05.411] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:16:0) after 4m39s
[22:29:44.390] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:16:0)
[22:29:44.410] Build status: SCHEDULED
[22:29:44.410] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:17:0) after 4m19s
[22:34:03.433] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:17:0)
[22:34:03.452] Build status: SCHEDULED
[22:34:03.452] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:18:0) after 5m56s
[22:39:59.479] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:18:0)
[22:39:59.509] Build status: SCHEDULED
[22:39:59.509] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:19:0) after 3m16s
[22:43:15.532] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:19:0)
[22:43:15.582] Build status: SCHEDULED
[22:43:15.582] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:20:0) after 2m53s
[22:46:08.588] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:20:0)
[22:46:08.609] Build status: SCHEDULED
[22:46:08.609] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:21:0) after 1m58s
[22:48:06.611] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:21:0)
[22:48:06.629] Build status: SCHEDULED
[22:48:06.629] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:22:0) after 9m40s
[22:49:16.668] Received PubSub notification, asking Buildbucket for the build status
[22:49:16.689] Build status: STARTED
[22:57:46.649] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:22:0)
[22:57:46.667] Build status: STARTED
[22:57:46.667] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:24:0) after 8m55s
[23:06:41.688] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:24:0)
[23:06:41.710] Build status: STARTED
[23:06:41.710] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:25:0) after 8m50s
[23:15:31.728] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:25:0)
[23:15:31.748] Build status: STARTED
[23:15:31.748] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:26:0) after 9m16s
[23:24:47.767] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:26:0)
[23:24:47.786] Build status: STARTED
[23:24:47.786] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:27:0) after 9m15s
[23:34:02.822] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:27:0)
[23:34:02.851] Build status: STARTED
[23:34:02.851] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:28:0) after 3m0s
[23:37:02.872] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:28:0)
[23:37:02.900] Build status: STARTED
[23:37:02.900] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:29:0) after 2m36s
[23:39:38.917] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:29:0)
[23:39:38.936] Build status: STARTED
[23:39:38.936] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:30:0) after 2m54s
[23:42:32.955] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:30:0)
[23:42:32.977] Build status: STARTED
[23:42:32.977] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:31:0) after 8m44s
[23:51:17.004] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:31:0)
[23:51:17.025] Build status: STARTED
[23:51:17.025] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:32:0) after 6m2s
[23:57:19.043] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:32:0)
[23:57:19.064] Build status: STARTED
[23:57:19.064] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:33:0) after 1m44s
[23:59:03.083] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:33:0)
[23:59:03.117] Build status: STARTED
[23:59:03.117] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:34:0) after 3m18s
[00:02:21.135] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:34:0)
[00:02:21.205] Build status: STARTED
[00:02:21.205] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:35:0) after 2m3s
[00:04:24.213] Handling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:35:0)
[00:04:24.236] Build status: STARTED
[00:04:24.236] Scheduling timer "check-buildbucket-build-status" (chromium-m130/Android arm Builder (dbg):8901401870174034560:36:0) after 8m30s
[00:07:07.913] Received PubSub notification, asking Buildbucket for the build status
[00:07:07.933] Build:
{
"id": "8735971808003418017",
"builder": {
"project": "chromium-m130",
"bucket": "ci",
"builder": "Android arm Builder (dbg)"
},
"number": 62,
"createdBy": "project:chromium-m130",
"createTime": "2024-09-23T20:58:00.066699898Z",
"startTime": "2024-09-23T22:49:16.499532974Z",
"endTime": "2024-09-24T00:07:02.746377398Z",
"updateTime": "2024-09-24T00:07:02.746377398Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "48088418e1e8cadf995109648677731cb2a6e097",
"ref": "refs/branch-heads/6723"
}
}
}
[00:07:07.933] Invocation finished in 3h9m9.320480601s with status SUCCEEDED