[01:33:06.661] New invocation is queued and will start shortly
[01:33:07.963] Starting the invocation (attempt 1)
[01:33:08.004] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2518ed029cf9e5e19ede97be0274a221705c0add"
[01:33:08.004] Popped gitiles commit info from properties and tags
[01:33:08.004] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:33:08.005] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:33:08.005] Buildbucket request:
{
"requestId": "8967520345739108128",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid x86"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2518ed029cf9e5e19ede97be0274a221705c0add",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967520345739108128"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTAndroid x86"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:33:08.653] Scheduled build:
{
"id": "8802090283564252401",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid x86"
},
"number": 6081,
"createdBy": "project:chromium",
"createTime": "2022-09-25T01:33:08.083547957Z",
"updateTime": "2022-09-25T01:33:08.083547957Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2518ed029cf9e5e19ede97be0274a221705c0add",
"ref": "refs/heads/main"
}
}
}
[01:33:08.653] Task URL: https://cr-buildbucket.appspot.com/build/8802090283564252401
[01:33:08.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:2:0) after 9m55s
[01:33:29.950] Received PubSub notification, asking Buildbucket for the build status
[01:33:29.972] Build status: STARTED
[01:43:03.679] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:2:0)
[01:43:03.705] Build status: STARTED
[01:43:03.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:4:0) after 7m26s
[01:50:29.723] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:4:0)
[01:50:29.745] Build status: STARTED
[01:50:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:5:0) after 3m14s
[01:53:43.760] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:5:0)
[01:53:43.781] Build status: STARTED
[01:53:43.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:6:0) after 9m55s
[02:03:38.799] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:6:0)
[02:03:38.870] Build status: STARTED
[02:03:38.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:7:0) after 6m4s
[02:09:42.890] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:7:0)
[02:09:42.917] Build status: STARTED
[02:09:42.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:8:0) after 3m44s
[02:13:26.938] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:8:0)
[02:13:26.960] Build status: STARTED
[02:13:26.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:9:0) after 8m50s
[02:22:16.981] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:9:0)
[02:22:17.008] Build status: STARTED
[02:22:17.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:10:0) after 4m59s
[02:27:16.112] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:10:0)
[02:27:16.136] Build status: STARTED
[02:27:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:11:0) after 5m48s
[02:33:04.170] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:11:0)
[02:33:04.192] Build status: STARTED
[02:33:04.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:12:0) after 5m7s
[02:38:11.169] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:12:0)
[02:38:11.188] Build status: STARTED
[02:38:11.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:13:0) after 9m2s
[02:47:13.665] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:13:0)
[02:47:13.718] Build status: STARTED
[02:47:13.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:14:0) after 4m40s
[02:51:53.940] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:14:0)
[02:51:53.975] Build status: STARTED
[02:51:53.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:15:0) after 5m45s
[02:57:38.960] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:15:0)
[02:57:38.989] Build status: STARTED
[02:57:38.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:16:0) after 3m57s
[03:01:36.011] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:16:0)
[03:01:36.040] Build status: STARTED
[03:01:36.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:17:0) after 3m1s
[03:04:37.093] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:17:0)
[03:04:37.128] Build status: STARTED
[03:04:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:18:0) after 2m18s
[03:06:55.207] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:18:0)
[03:06:55.233] Build status: STARTED
[03:06:55.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:19:0) after 9m12s
[03:16:07.262] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:19:0)
[03:16:07.283] Build status: STARTED
[03:16:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:20:0) after 6m6s
[03:22:13.317] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:20:0)
[03:22:13.349] Build status: STARTED
[03:22:13.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:21:0) after 8m20s
[03:30:33.546] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:21:0)
[03:30:33.576] Build status: STARTED
[03:30:33.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:22:0) after 4m50s
[03:35:23.635] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:22:0)
[03:35:23.664] Build status: STARTED
[03:35:23.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:23:0) after 8m18s
[03:43:41.685] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:23:0)
[03:43:41.712] Build status: STARTED
[03:43:41.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:24:0) after 7m49s
[03:51:30.733] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:24:0)
[03:51:30.760] Build status: STARTED
[03:51:30.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:25:0) after 5m31s
[03:57:01.825] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:25:0)
[03:57:01.853] Build status: STARTED
[03:57:01.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:26:0) after 3m19s
[04:00:20.903] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:26:0)
[04:00:20.943] Build status: STARTED
[04:00:20.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:27:0) after 6m44s
[04:07:04.966] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:27:0)
[04:07:04.991] Build status: STARTED
[04:07:04.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:28:0) after 1m46s
[04:08:51.015] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:28:0)
[04:08:51.037] Build status: STARTED
[04:08:51.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:29:0) after 3m42s
[04:12:33.211] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:29:0)
[04:12:33.236] Build status: STARTED
[04:12:33.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:30:0) after 7m15s
[04:19:48.335] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:30:0)
[04:19:48.359] Build status: STARTED
[04:19:48.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:31:0) after 9m59s
[04:29:47.480] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:31:0)
[04:29:47.502] Build status: STARTED
[04:29:47.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:32:0) after 9m11s
[04:38:58.529] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:32:0)
[04:38:58.555] Build status: STARTED
[04:38:58.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:33:0) after 4m50s
[04:43:48.595] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:33:0)
[04:43:48.621] Build status: STARTED
[04:43:48.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:34:0) after 6m43s
[04:50:31.652] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:34:0)
[04:50:31.689] Build status: STARTED
[04:50:31.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:35:0) after 7m34s
[04:58:05.700] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:35:0)
[04:58:05.731] Build status: STARTED
[04:58:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:36:0) after 7m40s
[05:05:45.832] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:36:0)
[05:05:45.857] Build status: STARTED
[05:05:45.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:37:0) after 6m12s
[05:11:57.946] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:37:0)
[05:11:57.970] Build status: STARTED
[05:11:57.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:38:0) after 4m27s
[05:16:24.992] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:38:0)
[05:16:25.021] Build status: STARTED
[05:16:25.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:39:0) after 3m45s
[05:20:10.054] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:39:0)
[05:20:10.081] Build status: STARTED
[05:20:10.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:40:0) after 1m23s
[05:21:33.164] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:40:0)
[05:21:33.186] Build status: STARTED
[05:21:33.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:41:0) after 2m38s
[05:24:11.182] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:41:0)
[05:24:11.224] Build status: STARTED
[05:24:11.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:42:0) after 9m3s
[05:33:14.247] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:42:0)
[05:33:14.272] Build status: STARTED
[05:33:14.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:43:0) after 1m18s
[05:34:32.292] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:43:0)
[05:34:32.314] Build status: STARTED
[05:34:32.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:44:0) after 7m48s
[05:42:20.348] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:44:0)
[05:42:20.375] Build status: STARTED
[05:42:20.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:45:0) after 2m9s
[05:44:29.504] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:45:0)
[05:44:29.528] Build status: STARTED
[05:44:29.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:46:0) after 7m51s
[05:52:20.556] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:46:0)
[05:52:20.579] Build status: STARTED
[05:52:20.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:47:0) after 3m34s
[05:55:54.559] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:47:0)
[05:55:54.587] Build status: STARTED
[05:55:54.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:48:0) after 5m33s
[06:01:27.695] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:48:0)
[06:01:27.716] Build status: STARTED
[06:01:27.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:49:0) after 8m30s
[06:09:57.738] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:49:0)
[06:09:57.765] Build status: STARTED
[06:09:57.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:50:0) after 1m3s
[06:11:00.941] Handling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:50:0)
[06:11:00.976] Build status: STARTED
[06:11:00.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTAndroid x86:8967520345739108128:51:0) after 6m1s
[06:13:31.298] Received PubSub notification, asking Buildbucket for the build status
[06:13:31.358] Build:
{
"id": "8802090283564252401",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTAndroid x86"
},
"number": 6081,
"createdBy": "project:chromium",
"createTime": "2022-09-25T01:33:08.083547957Z",
"startTime": "2022-09-25T01:33:29.488695Z",
"endTime": "2022-09-25T06:13:31.015669920Z",
"updateTime": "2022-09-25T06:13:31.015669920Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2518ed029cf9e5e19ede97be0274a221705c0add",
"ref": "refs/heads/main"
}
}
}
[06:13:31.358] Invocation finished in 4h40m24.732090148s with status SUCCEEDED