[00:09:12.564] New invocation is queued and will start shortly
[00:09:13.642] Starting the invocation (attempt 1)
[00:09:13.682] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f35c1c54fea01b17879b40d642b0e50725106a26"
[00:09:13.682] Popped gitiles commit info from properties and tags
[00:09:13.682] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:09:13.682] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:09:13.682] Buildbucket request:
{
"requestId": "8989268896287814736",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f35c1c54fea01b17879b40d642b0e50725106a26",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8989268896287814736"
},
{
"key": "scheduler_job_id",
"value": "chromium/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:09:16.216] Scheduled build:
{
"id": "8823838834372313905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"number": 2993,
"createdBy": "project:chromium",
"createTime": "2022-01-28T00:09:13.759026003Z",
"updateTime": "2022-01-28T00:09:13.759026003Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f35c1c54fea01b17879b40d642b0e50725106a26",
"ref": "refs/heads/main"
}
}
}
[00:09:16.216] Task URL: https://cr-buildbucket.appspot.com/build/8823838834372313905
[00:09:16.216] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:2:0) after 7m15s
[00:09:23.450] Received PubSub notification, asking Buildbucket for the build status
[00:09:23.470] Build status: STARTED
[00:16:31.292] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:2:0)
[00:16:31.316] Build status: STARTED
[00:16:31.316] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:4:0) after 2m41s
[00:19:12.338] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:4:0)
[00:19:12.364] Build status: STARTED
[00:19:12.364] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:5:0) after 8m58s
[00:28:10.622] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:5:0)
[00:28:10.643] Build status: STARTED
[00:28:10.643] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:6:0) after 9m22s
[00:37:32.667] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:6:0)
[00:37:32.692] Build status: STARTED
[00:37:32.692] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:7:0) after 4m43s
[00:42:15.716] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:7:0)
[00:42:15.736] Build status: STARTED
[00:42:15.736] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:8:0) after 1m58s
[00:44:13.794] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:8:0)
[00:44:13.826] Build status: STARTED
[00:44:13.826] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:9:0) after 4m16s
[00:48:29.846] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:9:0)
[00:48:29.864] Build status: STARTED
[00:48:29.864] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:10:0) after 4m34s
[00:53:03.884] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:10:0)
[00:53:03.908] Build status: STARTED
[00:53:03.908] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:11:0) after 8m0s
[01:01:03.930] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:11:0)
[01:01:03.950] Build status: STARTED
[01:01:03.950] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:12:0) after 4m6s
[01:05:10.177] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:12:0)
[01:05:10.201] Build status: STARTED
[01:05:10.201] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:13:0) after 3m48s
[01:08:58.251] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:13:0)
[01:08:58.359] Build status: STARTED
[01:08:58.359] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:14:0) after 8m55s
[01:17:53.440] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:14:0)
[01:17:53.461] Build status: STARTED
[01:17:53.461] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:15:0) after 9m34s
[01:27:27.747] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:15:0)
[01:27:27.775] Build status: STARTED
[01:27:27.775] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:16:0) after 9m30s
[01:36:58.010] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:16:0)
[01:36:58.029] Build status: STARTED
[01:36:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:17:0) after 4m52s
[01:41:50.149] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:17:0)
[01:41:50.169] Build status: STARTED
[01:41:50.169] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:18:0) after 8m1s
[01:49:51.611] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:18:0)
[01:49:51.639] Build status: STARTED
[01:49:51.639] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:19:0) after 8m40s
[01:58:31.660] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:19:0)
[01:58:31.682] Build status: STARTED
[01:58:31.682] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:20:0) after 7m9s
[02:05:40.703] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:20:0)
[02:05:40.739] Build status: STARTED
[02:05:40.739] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:21:0) after 8m2s
[02:13:42.792] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:21:0)
[02:13:42.853] Build status: STARTED
[02:13:42.853] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:22:0) after 9m26s
[02:23:08.977] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:22:0)
[02:23:09.008] Build status: STARTED
[02:23:09.008] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:23:0) after 9m44s
[02:32:53.133] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:23:0)
[02:32:53.157] Build status: STARTED
[02:32:53.158] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:24:0) after 2m17s
[02:35:10.179] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:24:0)
[02:35:10.261] Build status: STARTED
[02:35:10.261] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:25:0) after 3m45s
[02:38:55.350] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:25:0)
[02:38:55.369] Build status: STARTED
[02:38:55.369] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:26:0) after 9m49s
[02:48:44.393] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:26:0)
[02:48:44.412] Build status: STARTED
[02:48:44.412] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:27:0) after 2m34s
[02:51:18.447] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:27:0)
[02:51:18.473] Build status: STARTED
[02:51:18.473] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:28:0) after 7m42s
[02:59:00.472] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:28:0)
[02:59:00.568] Build status: STARTED
[02:59:00.568] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:29:0) after 6m4s
[03:05:04.626] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:29:0)
[03:05:04.654] Build status: STARTED
[03:05:04.655] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:30:0) after 1m17s
[03:06:21.696] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:30:0)
[03:06:21.720] Build status: STARTED
[03:06:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:31:0) after 5m42s
[03:12:03.703] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:31:0)
[03:12:03.723] Build status: STARTED
[03:12:03.723] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:32:0) after 9m15s
[03:21:19.228] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:32:0)
[03:21:19.262] Build status: STARTED
[03:21:19.262] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:33:0) after 4m22s
[03:25:41.390] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:33:0)
[03:25:41.423] Build status: STARTED
[03:25:41.423] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:34:0) after 2m54s
[03:28:35.618] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:34:0)
[03:28:35.639] Build status: STARTED
[03:28:35.639] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:35:0) after 9m27s
[03:38:02.665] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:35:0)
[03:38:02.750] Build status: STARTED
[03:38:02.750] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:36:0) after 1m52s
[03:39:54.773] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:36:0)
[03:39:54.794] Build status: STARTED
[03:39:54.794] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:37:0) after 8m55s
[03:48:49.833] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:37:0)
[03:48:49.851] Build status: STARTED
[03:48:49.852] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:38:0) after 8m31s
[03:57:20.872] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:38:0)
[03:57:20.901] Build status: STARTED
[03:57:20.901] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:39:0) after 6m19s
[04:03:40.076] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:39:0)
[04:03:40.100] Build status: STARTED
[04:03:40.100] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:40:0) after 2m40s
[04:06:20.370] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:40:0)
[04:06:20.396] Build status: STARTED
[04:06:20.396] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:41:0) after 7m52s
[04:14:12.617] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:41:0)
[04:14:12.637] Build status: STARTED
[04:14:12.637] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:42:0) after 4m45s
[04:18:57.830] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:42:0)
[04:18:57.849] Build status: STARTED
[04:18:57.849] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:43:0) after 2m11s
[04:21:09.043] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:43:0)
[04:21:09.064] Build status: STARTED
[04:21:09.064] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:44:0) after 6m31s
[04:27:40.080] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:44:0)
[04:27:40.148] Build status: STARTED
[04:27:40.148] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:45:0) after 3m56s
[04:31:36.174] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:45:0)
[04:31:36.195] Build status: STARTED
[04:31:36.195] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:46:0) after 7m40s
[04:39:16.204] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:46:0)
[04:39:16.224] Build status: STARTED
[04:39:16.224] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:47:0) after 9m52s
[04:49:08.697] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:47:0)
[04:49:08.716] Build status: STARTED
[04:49:08.716] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:48:0) after 1m7s
[04:50:15.741] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:48:0)
[04:50:15.762] Build status: STARTED
[04:50:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:49:0) after 7m26s
[04:57:41.791] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:49:0)
[04:57:41.819] Build status: STARTED
[04:57:41.819] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:50:0) after 8m22s
[05:06:03.842] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:50:0)
[05:06:03.867] Build status: STARTED
[05:06:03.867] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:51:0) after 6m21s
[05:12:24.892] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:51:0)
[05:12:24.917] Build status: STARTED
[05:12:24.917] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:52:0) after 3m51s
[05:16:15.940] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:52:0)
[05:16:16.073] Build status: STARTED
[05:16:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:53:0) after 1m19s
[05:17:35.204] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:53:0)
[05:17:35.226] Build status: STARTED
[05:17:35.226] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:54:0) after 3m9s
[05:20:44.261] Handling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:54:0)
[05:20:44.310] Build status: STARTED
[05:20:44.310] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:8989268896287814736:55:0) after 1m25s
[05:21:26.621] Received PubSub notification, asking Buildbucket for the build status
[05:21:26.690] Build:
{
"id": "8823838834372313905",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "mac-official"
},
"number": 2993,
"createdBy": "project:chromium",
"createTime": "2022-01-28T00:09:13.759026003Z",
"startTime": "2022-01-28T00:09:22.746840Z",
"endTime": "2022-01-28T05:21:26.180530786Z",
"updateTime": "2022-01-28T05:21:26.180530786Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f35c1c54fea01b17879b40d642b0e50725106a26",
"ref": "refs/heads/main"
}
}
}
[05:21:26.690] Invocation finished in 5h12m14.141612533s with status SUCCEEDED