[42.745395] Initializing watchdogs [42.745484] /dev/watchdog0 [42.752214] [001/171] (960s left) i915_module_load (load) [42.817829] Starting subtest: load [43.718853] Subtest load: SUCCESS (0.900s) [43.743790] [002/171] (959s left) core_auth (basic-auth) [43.857795] Starting subtest: basic-auth [43.858849] Subtest basic-auth: SUCCESS (0.001s) [43.913655] [003/171] (959s left) debugfs_test (read_all_entries) [43.983750] Starting subtest: read_all_entries [44.034842] Subtest read_all_entries: SUCCESS (0.051s) [44.113487] [004/171] (959s left) debugfs_test (basic-hwmon) [44.176496] Starting subtest: basic-hwmon [44.178591] Subtest basic-hwmon: SKIP (0.000s) [44.246316] [005/171] (959s left) fbdev (eof) [44.318503] Starting subtest: eof [44.319670] Subtest eof: SUCCESS (0.000s) [44.364132] [006/171] (958s left) fbdev (info) [44.424173] Starting subtest: info [44.425330] Subtest info: SUCCESS (0.000s) [44.480807] [007/171] (958s left) fbdev (nullptr) [44.552312] Starting subtest: nullptr [44.553376] Subtest nullptr: SUCCESS (0.000s) [44.596509] [008/171] (958s left) fbdev (read) [44.667950] Starting subtest: read [44.748668] Subtest read: SUCCESS (0.080s) [44.779842] [009/171] (958s left) fbdev (write) [44.851520] Starting subtest: write [44.890855] Subtest write: SUCCESS (0.039s) [44.930292] [010/171] (958s left) gem_basic (bad-close) [44.992718] Starting subtest: bad-close [44.994828] Subtest bad-close: SUCCESS (0.000s) [45.047273] [011/171] (958s left) gem_basic (create-close) [45.108876] Starting subtest: create-close [45.110913] Subtest create-close: SUCCESS (0.000s) [45.180341] [012/171] (958s left) gem_basic (create-fd-close) [45.242232] Starting subtest: create-fd-close [45.244274] Subtest create-fd-close: SUCCESS (0.000s) [45.314242] [013/171] (958s left) gem_busy (busy@all-engines) [45.386332] Starting subtest: busy [45.387423] Starting dynamic subtest: all-engines [45.411201] Dynamic subtest all-engines: SUCCESS (0.025s) [45.412280] Subtest busy: SUCCESS (0.025s) [45.715527] [014/171] (957s left) gem_close_race (basic-process) [45.790015] Starting subtest: basic-process [45.823407] Subtest basic-process: SUCCESS (0.033s) [45.980538] [015/171] (957s left) gem_close_race (basic-threads) [46.051787] Starting subtest: basic-threads [47.205065] Subtest basic-threads: SUCCESS (1.152s) [47.366324] [016/171] (956s left) gem_ctx_create (basic) [47.437391] Starting subtest: basic [47.438496] Subtest basic: SUCCESS (0.000s) [47.597753] [017/171] (955s left) gem_ctx_create (basic-files) [47.665969] Starting subtest: basic-files [49.678946] Subtest basic-files: SUCCESS (2.013s) [49.962812] [018/171] (953s left) gem_ctx_exec (basic) [50.029783] Starting subtest: basic [50.032588] Subtest basic: SUCCESS (0.003s) [50.115493] [019/171] (953s left) gem_exec_basic (basic) [50.182207] Starting subtest: basic [50.183289] Starting dynamic subtest: rcs0-smem [50.184354] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [50.190144] Starting dynamic subtest: bcs0-smem [50.191175] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [50.196412] Starting dynamic subtest: vcs0-smem [50.197478] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [50.202757] Starting dynamic subtest: vecs0-smem [50.203926] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [50.204989] Subtest basic: SUCCESS (0.002s) [50.346935] [020/171] (953s left) gem_exec_create (basic) [50.415908] Starting subtest: basic [50.416989] Starting dynamic subtest: smem [52.459592] Dynamic subtest smem: SUCCESS (2.043s) [52.461230] Subtest basic: SUCCESS (2.044s) [52.617567] [021/171] (950s left) gem_exec_fence (basic-busy) [52.798602] Starting subtest: basic-busy [52.799767] Starting dynamic subtest: rcs0 [52.830444] Dynamic subtest rcs0: SUCCESS (0.032s) [52.837801] Starting dynamic subtest: bcs0 [52.850146] Dynamic subtest bcs0: SUCCESS (0.020s) [52.855692] Starting dynamic subtest: vcs0 [52.874178] Dynamic subtest vcs0: SUCCESS (0.024s) [52.879819] Starting dynamic subtest: vecs0 [52.899227] Dynamic subtest vecs0: SUCCESS (0.025s) [52.900301] Subtest basic-busy: SUCCESS (0.101s) [53.346228] [022/171] (950s left) gem_exec_fence (basic-wait) [53.529422] Starting subtest: basic-wait [53.530548] Starting dynamic subtest: rcs0 [53.565411] Dynamic subtest rcs0: SUCCESS (0.036s) [53.572266] Starting dynamic subtest: bcs0 [53.587224] Dynamic subtest bcs0: SUCCESS (0.022s) [53.593893] Starting dynamic subtest: vcs0 [53.614229] Dynamic subtest vcs0: SUCCESS (0.027s) [53.621637] Starting dynamic subtest: vecs0 [53.634170] Dynamic subtest vecs0: SUCCESS (0.020s) [53.635274] Subtest basic-wait: SUCCESS (0.105s) [54.061492] [023/171] (949s left) gem_exec_fence (basic-await) [54.245796] Starting subtest: basic-await [54.246862] Starting dynamic subtest: rcs0 [54.316027] Dynamic subtest rcs0: SUCCESS (0.070s) [54.322692] Starting dynamic subtest: bcs0 [54.389514] Dynamic subtest bcs0: SUCCESS (0.073s) [54.395044] Starting dynamic subtest: vcs0 [54.460773] Dynamic subtest vcs0: SUCCESS (0.070s) [54.466256] Starting dynamic subtest: vecs0 [54.531429] Dynamic subtest vecs0: SUCCESS (0.070s) [54.532520] Subtest basic-await: SUCCESS (0.285s) [54.944682] [024/171] (948s left) gem_exec_fence (nb-await) [55.127303] Starting subtest: nb-await [55.128265] Starting dynamic subtest: rcs0 [55.181338] Dynamic subtest rcs0: SUCCESS (0.054s) [55.187374] Starting dynamic subtest: bcs0 [55.234564] Dynamic subtest bcs0: SUCCESS (0.053s) [55.240779] Starting dynamic subtest: vcs0 [55.288659] Dynamic subtest vcs0: SUCCESS (0.054s) [55.294410] Starting dynamic subtest: vecs0 [55.342835] Dynamic subtest vecs0: SUCCESS (0.053s) [55.344088] Subtest nb-await: SUCCESS (0.216s) [55.761735] [025/171] (947s left) gem_exec_gttfill (basic) [55.832390] Starting subtest: basic [58.802765] Subtest basic: SUCCESS (2.970s) [58.960430] [026/171] (944s left) gem_exec_parallel (engines) [59.093235] Starting subtest: engines [59.094328] Starting dynamic subtest: basic [60.495254] Dynamic subtest basic: SUCCESS (1.401s) [60.502232] Starting dynamic subtest: contexts [62.070403] Dynamic subtest contexts: SUCCESS (1.575s) [62.076872] Starting dynamic subtest: fds [63.858877] Dynamic subtest fds: SUCCESS (1.789s) [63.865466] Starting dynamic subtest: userptr [65.323074] Dynamic subtest userptr: SUCCESS (1.464s) [65.324282] Subtest engines: SUCCESS (6.230s) [65.499706] [027/171] (938s left) gem_exec_store (basic) [65.573375] Starting subtest: basic [65.608496] Subtest basic: SUCCESS (0.034s) [65.778148] [028/171] (937s left) gem_flink_basic (bad-flink) [65.840755] Starting subtest: bad-flink [65.841884] Subtest bad-flink: SUCCESS (0.000s) [65.892620] [029/171] (937s left) gem_flink_basic (bad-open) [65.956027] Starting subtest: bad-open [65.957084] Subtest bad-open: SUCCESS (0.000s) [66.009333] [030/171] (937s left) gem_flink_basic (basic) [66.068975] Starting subtest: basic [66.069990] Subtest basic: SUCCESS (0.000s) [66.143584] [031/171] (937s left) gem_flink_basic (double-flink) [66.205483] Starting subtest: double-flink [66.206593] Subtest double-flink: SUCCESS (0.000s) [66.279112] [032/171] (937s left) gem_flink_basic (flink-lifetime) [66.341094] Starting subtest: flink-lifetime [66.342230] Subtest flink-lifetime: SUCCESS (0.001s) [66.411425] [033/171] (937s left) gem_huc_copy (huc-copy) [66.476988] Subtest huc-copy: SKIP (0.000s) [66.506994] [034/171] (937s left) gem_linear_blits (basic) [66.639214] Starting subtest: basic [66.645385] Subtest basic: SUCCESS (0.007s) [66.753620] [035/171] (936s left) gem_mmap (basic) [66.888148] Starting subtest: basic [66.893521] Subtest basic: SUCCESS (0.000s) [66.962373] [036/171] (936s left) gem_mmap_gtt (basic) [67.025316] Starting subtest: basic [67.026412] Subtest basic: SUCCESS (0.000s) [67.070809] [037/171] (936s left) gem_render_linear_blits (basic) [67.132239] Starting subtest: basic [67.147766] Subtest basic: SUCCESS (0.016s) [67.187949] [038/171] (936s left) gem_render_tiled_blits (basic) [67.252951] Starting subtest: basic [67.271837] Subtest basic: SUCCESS (0.019s) [67.320968] [039/171] (936s left) gem_ringfill (basic-all) [67.510544] Starting subtest: basic-all [68.616287] Subtest basic-all: SUCCESS (1.106s) [68.692383] [040/171] (935s left) gem_softpin (allocator-basic) [68.757612] Subtest allocator-basic: SKIP (0.000s) [68.809436] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [68.873469] Subtest allocator-basic-reserve: SKIP (0.000s) [68.925415] [042/171] (934s left) gem_softpin (safe-alignment) [68.988897] Starting subtest: safe-alignment [68.996163] Subtest safe-alignment: SUCCESS (0.008s) [69.075303] [043/171] (934s left) gem_sync (basic-all) [69.143944] Starting subtest: basic-all [71.319347] Subtest basic-all: SUCCESS (2.175s) [71.475261] [044/171] (932s left) gem_sync (basic-each) [71.545141] Starting subtest: basic-each [73.615973] Subtest basic-each: SUCCESS (2.070s) [73.774559] [045/171] (930s left) gem_tiled_blits (basic) [73.901804] Starting subtest: basic [73.911433] Subtest basic: SUCCESS (0.010s) [74.016095] [046/171] (929s left) gem_tiled_fence_blits (basic) [74.213188] Starting subtest: basic [74.218729] Subtest basic: SUCCESS (0.006s) [74.317065] [047/171] (929s left) gem_tiled_pread_basic [74.608032] [048/171] (929s left) gem_wait (busy@all-engines) [74.682621] Starting subtest: busy [74.683681] Starting dynamic subtest: all-engines [75.200304] Dynamic subtest all-engines: SUCCESS (0.517s) [75.201526] Subtest busy: SUCCESS (0.517s) [75.375224] [049/171] (928s left) gem_wait (wait@all-engines) [75.448054] Starting subtest: wait [75.449166] Starting dynamic subtest: all-engines [76.464144] Dynamic subtest all-engines: SUCCESS (1.016s) [76.465292] Subtest wait: SUCCESS (1.016s) [76.640685] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [76.703740] Starting subtest: basic-eu-total [76.705939] Subtest basic-eu-total: SUCCESS (0.000s) [76.757649] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [76.818155] Starting subtest: basic-subslice-total [76.820141] Subtest basic-subslice-total: SUCCESS (0.000s) [76.874123] [052/171] (927s left) i915_hangman (error-state-basic) [76.942226] Starting subtest: error-state-basic [76.949734] Subtest error-state-basic: SUCCESS (0.004s) [77.023858] [053/171] (926s left) i915_pciid [77.140384] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier) [77.205217] Starting subtest: addfb25-bad-modifier [77.206240] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [77.307040] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [77.370121] Starting subtest: addfb25-framebuffer-vs-set-tiling [77.371336] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [77.456505] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [77.517256] Starting subtest: addfb25-modifier-no-flag [77.518295] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [77.606926] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [77.670959] Starting subtest: addfb25-x-tiled-legacy [77.671977] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [77.757460] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [77.818744] Starting subtest: addfb25-x-tiled-mismatch-legacy [77.819819] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [77.908559] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [78.002718] Starting subtest: addfb25-yf-tiled-legacy [78.003852] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [78.074637] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [78.158257] Starting subtest: addfb25-y-tiled-legacy [78.159283] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [78.224031] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [78.307807] Starting subtest: addfb25-y-tiled-small-legacy [78.309939] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [78.376165] [062/171] (925s left) kms_addfb_basic (bad-pitch-0) [78.438428] Starting subtest: bad-pitch-0 [78.439471] Subtest bad-pitch-0: SUCCESS (0.000s) [78.522714] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [78.585142] Starting subtest: bad-pitch-1024 [78.586292] Subtest bad-pitch-1024: SUCCESS (0.000s) [78.673256] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [78.735528] Starting subtest: bad-pitch-128 [78.736503] Subtest bad-pitch-128: SUCCESS (0.000s) [78.823206] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [78.884403] Starting subtest: bad-pitch-256 [78.885458] Subtest bad-pitch-256: SUCCESS (0.000s) [78.974302] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [79.036539] Starting subtest: bad-pitch-32 [79.037701] Subtest bad-pitch-32: SUCCESS (0.000s) [79.122559] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [79.185419] Starting subtest: bad-pitch-63 [79.186552] Subtest bad-pitch-63: SUCCESS (0.000s) [79.272580] [068/171] (924s left) kms_addfb_basic (bad-pitch-65536) [79.333472] Starting subtest: bad-pitch-65536 [79.334605] Subtest bad-pitch-65536: SUCCESS (0.000s) [79.423950] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [79.486061] Starting subtest: bad-pitch-999 [79.487123] Subtest bad-pitch-999: SUCCESS (0.000s) [79.572465] [070/171] (924s left) kms_addfb_basic (basic) [79.634359] Starting subtest: basic [79.635434] Subtest basic: SUCCESS (0.000s) [79.723547] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [79.786356] Starting subtest: basic-x-tiled-legacy [79.787476] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [79.872480] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [79.936165] Starting subtest: basic-y-tiled-legacy [79.937183] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [80.022815] [073/171] (924s left) kms_addfb_basic (bo-too-small) [80.110474] Starting subtest: bo-too-small [80.111559] Subtest bo-too-small: SUCCESS (0.000s) [80.189750] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [80.274472] Starting subtest: bo-too-small-due-to-tiling [80.275620] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [80.342592] [075/171] (923s left) kms_addfb_basic (clobberred-modifier) [80.403058] Starting subtest: clobberred-modifier [80.404088] Subtest clobberred-modifier: SUCCESS (0.000s) [80.488797] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [80.551139] Starting subtest: framebuffer-vs-set-tiling [80.552235] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [80.639181] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [80.698950] Starting subtest: invalid-get-prop [80.699964] Subtest invalid-get-prop: SUCCESS (0.000s) [80.789409] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [80.850482] Starting subtest: invalid-get-prop-any [80.851474] Subtest invalid-get-prop-any: SUCCESS (0.000s) [80.938897] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [81.001889] Starting subtest: invalid-set-prop [81.002920] Subtest invalid-set-prop: SUCCESS (0.000s) [81.090760] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [81.153213] Starting subtest: invalid-set-prop-any [81.154234] Subtest invalid-set-prop-any: SUCCESS (0.000s) [81.238379] [081/171] (923s left) kms_addfb_basic (no-handle) [81.299716] Starting subtest: no-handle [81.300786] Subtest no-handle: SUCCESS (0.000s) [81.405594] [082/171] (923s left) kms_addfb_basic (size-max) [81.490338] Starting subtest: size-max [81.491315] Subtest size-max: SUCCESS (0.000s) [81.572215] [083/171] (922s left) kms_addfb_basic (small-bo) [81.656332] Starting subtest: small-bo [81.657356] Subtest small-bo: SUCCESS (0.000s) [81.740589] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [81.804254] Starting subtest: tile-pitch-mismatch [81.805374] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [81.888552] [085/171] (922s left) kms_addfb_basic (too-high) [81.979555] Starting subtest: too-high [81.980731] Subtest too-high: SUCCESS (0.001s) [82.055179] [086/171] (922s left) kms_addfb_basic (too-wide) [82.139240] Starting subtest: too-wide [82.140318] Subtest too-wide: SUCCESS (0.000s) [82.204917] [087/171] (922s left) kms_addfb_basic (unused-handle) [82.266238] Starting subtest: unused-handle [82.267369] Subtest unused-handle: SUCCESS (0.000s) [82.355785] [088/171] (922s left) kms_addfb_basic (unused-modifier) [82.416484] Starting subtest: unused-modifier [82.417567] Subtest unused-modifier: SUCCESS (0.000s) [82.505970] [089/171] (922s left) kms_addfb_basic (unused-offsets) [82.568262] Starting subtest: unused-offsets [82.569370] Subtest unused-offsets: SUCCESS (0.000s) [82.655950] [090/171] (921s left) kms_addfb_basic (unused-pitches) [82.716591] Starting subtest: unused-pitches [82.717691] Subtest unused-pitches: SUCCESS (0.000s) [82.805455] [091/171] (921s left) kms_busy (basic) [82.889644] Starting subtest: basic [82.890764] Starting dynamic subtest: flip [83.329413] Dynamic subtest flip: SUCCESS (0.439s) [83.336632] Starting dynamic subtest: modeset [83.892623] Dynamic subtest modeset: SUCCESS (0.563s) [83.893502] Subtest basic: SUCCESS (1.003s) [84.022634] [092/171] (920s left) kms_chamelium_hpd (dp-hpd-fast) [84.148986] Subtest dp-hpd-fast: SKIP (0.000s) [84.233461] [093/171] (920s left) kms_chamelium_edid (dp-edid-read) [84.361813] Subtest dp-edid-read: SKIP (0.000s) [84.445831] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [84.574513] Subtest dp-crc-fast: SKIP (0.000s) [84.658905] [095/171] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [84.788760] Subtest hdmi-hpd-fast: SKIP (0.000s) [84.873706] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [85.002882] Subtest hdmi-edid-read: SKIP (0.000s) [85.090165] [097/171] (919s left) kms_chamelium_frames (hdmi-crc-fast) [85.220878] Subtest hdmi-crc-fast: SKIP (0.000s) [85.305689] [098/171] (919s left) kms_chamelium_hpd (vga-hpd-fast) [85.434847] Subtest vga-hpd-fast: SKIP (0.000s) [85.519766] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [85.649729] Subtest vga-edid-read: SKIP (0.000s) [85.733481] [100/171] (918s left) kms_prop_blob (basic) [85.795748] Starting subtest: basic [85.797012] Subtest basic: SUCCESS (0.000s) [85.853681] [101/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [85.943055] Starting subtest: basic-busy-flip-before-cursor-atomic [86.876521] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.934s) [87.008474] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [87.093282] Starting subtest: basic-busy-flip-before-cursor-legacy [88.015382] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.923s) [88.145140] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [88.229265] Starting subtest: basic-flip-after-cursor-atomic [89.167501] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.938s) [89.300252] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [89.382439] Starting subtest: basic-flip-after-cursor-legacy [90.305472] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s) [90.434666] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [90.516771] Starting subtest: basic-flip-after-cursor-varying-size [91.442358] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s) [91.570185] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [91.652899] Starting subtest: basic-flip-before-cursor-atomic [92.575929] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s) [92.712384] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [92.794420] Starting subtest: basic-flip-before-cursor-legacy [93.718782] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s) [93.850152] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [93.934261] Starting subtest: basic-flip-before-cursor-varying-size [94.872332] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.939s) [95.001431] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [95.074816] Starting subtest: basic-flip-vs-dpms [95.077133] Starting dynamic subtest: A-VGA1 [96.023862] Dynamic subtest A-VGA1: SUCCESS (0.946s) [96.030529] Starting dynamic subtest: B-VGA1 [96.925953] Dynamic subtest B-VGA1: SUCCESS (0.901s) [96.932573] Starting dynamic subtest: C-VGA1 [97.825193] Dynamic subtest C-VGA1: SUCCESS (0.900s) [97.827997] Subtest basic-flip-vs-dpms: SUCCESS (2.753s) [97.961173] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [98.036453] Starting subtest: basic-flip-vs-modeset [98.037429] Starting dynamic subtest: A-VGA1 [98.900285] Dynamic subtest A-VGA1: SUCCESS (0.863s) [98.908711] Starting dynamic subtest: B-VGA1 [99.699668] Dynamic subtest B-VGA1: SUCCESS (0.798s) [99.707952] Starting dynamic subtest: C-VGA1 [100.496893] Dynamic subtest C-VGA1: SUCCESS (0.798s) [100.499193] Subtest basic-flip-vs-modeset: SUCCESS (2.463s) [100.634527] [111/171] (904s left) kms_flip (basic-flip-vs-wf_vblank) [100.711381] Starting subtest: basic-flip-vs-wf_vblank [100.712442] Starting dynamic subtest: A-VGA1 [101.858225] Dynamic subtest A-VGA1: SUCCESS (1.146s) [101.865980] Starting dynamic subtest: B-VGA1 [102.981439] Dynamic subtest B-VGA1: SUCCESS (1.122s) [102.988852] Starting dynamic subtest: C-VGA1 [104.105181] Dynamic subtest C-VGA1: SUCCESS (1.123s) [104.107292] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.397s) [104.276229] [112/171] (900s left) kms_flip (basic-plain-flip) [104.348993] Starting subtest: basic-plain-flip [104.351536] Starting dynamic subtest: A-VGA1 [105.198708] Dynamic subtest A-VGA1: SUCCESS (0.848s) [105.206052] Starting dynamic subtest: B-VGA1 [106.037656] Dynamic subtest B-VGA1: SUCCESS (0.838s) [106.045254] Starting dynamic subtest: C-VGA1 [106.877281] Dynamic subtest C-VGA1: SUCCESS (0.839s) [106.879830] Subtest basic-plain-flip: SUCCESS (2.531s) [107.049073] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [107.123533] Starting subtest: force-connector-state [107.260808] Subtest force-connector-state: SUCCESS (0.137s) [107.438567] [114/171] (897s left) kms_force_connector_basic (force-edid) [107.512742] Starting subtest: force-edid [107.535082] Subtest force-edid: SUCCESS (0.024s) [107.638576] [115/171] (897s left) kms_force_connector_basic (force-load-detect) [107.712360] Starting subtest: force-load-detect [107.854236] Subtest force-load-detect: SUCCESS (0.142s) [108.036734] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes) [108.110752] Starting subtest: prune-stale-modes [108.126844] Subtest prune-stale-modes: SUCCESS (0.017s) [108.220190] [117/171] (896s left) kms_frontbuffer_tracking (basic) [108.309240] Starting subtest: basic [110.105365] Subtest basic: SUCCESS (1.799s) [110.169613] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [110.253237] Starting subtest: compare-crc-sanitycheck-xr24 [110.254293] Starting dynamic subtest: pipe-A-VGA-1 [110.528192] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.274s) [110.535644] Starting dynamic subtest: pipe-B-VGA-1 [110.793053] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.264s) [110.799775] Starting dynamic subtest: pipe-C-VGA-1 [111.066119] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.272s) [111.067140] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.813s) [111.194797] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [111.277969] Starting subtest: compare-crc-sanitycheck-nv12 [111.279047] Starting dynamic subtest: pipe-A-VGA-1 [111.281104] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [111.287894] Starting dynamic subtest: pipe-B-VGA-1 [111.289947] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [111.296468] Starting dynamic subtest: pipe-C-VGA-1 [111.298593] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [111.300681] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [111.344646] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc) [111.426961] Starting subtest: hang-read-crc [111.428064] Starting dynamic subtest: pipe-A-VGA-1 [112.160144] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.732s) [112.166858] Starting dynamic subtest: pipe-B-VGA-1 [112.886151] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.725s) [112.892947] Starting dynamic subtest: pipe-C-VGA-1 [113.631360] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.744s) [113.632426] Subtest hang-read-crc: SUCCESS (2.204s) [113.748205] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc) [113.834440] Starting subtest: nonblocking-crc [113.835596] Starting dynamic subtest: pipe-A-VGA-1 [114.272203] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.436s) [114.279107] Starting dynamic subtest: pipe-B-VGA-1 [114.701314] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.428s) [114.708279] Starting dynamic subtest: pipe-C-VGA-1 [115.141474] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.439s) [115.142573] Subtest nonblocking-crc: SUCCESS (1.307s) [115.258656] [122/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [115.342467] Starting subtest: nonblocking-crc-frame-sequence [115.343623] Starting dynamic subtest: pipe-A-VGA-1 [115.782802] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.440s) [115.789627] Starting dynamic subtest: pipe-B-VGA-1 [116.210135] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.427s) [116.219045] Starting dynamic subtest: pipe-C-VGA-1 [116.647930] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.436s) [116.648983] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.307s) [116.764116] [123/171] (888s left) kms_pipe_crc_basic (read-crc) [116.856397] Starting subtest: read-crc [116.857436] Starting dynamic subtest: pipe-A-VGA-1 [117.221925] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.364s) [117.228852] Starting dynamic subtest: pipe-B-VGA-1 [117.583303] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [117.590287] Starting dynamic subtest: pipe-C-VGA-1 [117.954281] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [117.955288] Subtest read-crc: SUCCESS (1.098s) [118.070331] [124/171] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [118.155160] Starting subtest: read-crc-frame-sequence [118.156244] Starting dynamic subtest: pipe-A-VGA-1 [118.528234] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.372s) [118.537305] Starting dynamic subtest: pipe-B-VGA-1 [118.894910] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.366s) [118.901858] Starting dynamic subtest: pipe-C-VGA-1 [119.266059] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [119.267122] Subtest read-crc-frame-sequence: SUCCESS (1.111s) [119.383253] [125/171] (885s left) kms_psr (primary_page_flip) [119.446930] Subtest primary_page_flip: SKIP (0.000s) [119.477611] [126/171] (885s left) kms_psr (cursor_plane_move) [119.539981] Subtest cursor_plane_move: SKIP (0.000s) [119.560781] [127/171] (885s left) kms_psr (sprite_plane_onoff) [119.622979] Subtest sprite_plane_onoff: SKIP (0.000s) [119.644117] [128/171] (885s left) kms_psr (primary_mmap_gtt) [119.706975] Subtest primary_mmap_gtt: SKIP (0.000s) [119.727230] [129/171] (885s left) kms_setmode (basic-clone-single-crtc) [119.790217] Starting subtest: basic-clone-single-crtc [119.793445] Subtest basic-clone-single-crtc: SKIP (0.000s) [119.849597] [130/171] (885s left) i915_pm_backlight (basic-brightness) [119.932682] Subtest basic-brightness: SKIP (0.000s) [119.961207] [131/171] (885s left) i915_pm_rpm (basic-pci-d3-state) [121.325967] Starting subtest: basic-pci-d3-state [121.529906] Subtest basic-pci-d3-state: SUCCESS (0.202s) [121.775188] [132/171] (883s left) i915_pm_rpm (basic-rte) [121.836123] Starting subtest: basic-rte [123.327669] Subtest basic-rte: SUCCESS (1.489s) [123.770720] [133/171] (881s left) i915_pm_rps (basic-api) [123.842764] Starting subtest: basic-api [123.843876] Subtest basic-api: SUCCESS (0.002s) [123.902796] [134/171] (881s left) prime_self_import (basic-llseek-bad) [123.964779] Starting subtest: basic-llseek-bad [123.966901] Subtest basic-llseek-bad: SUCCESS (0.002s) [124.034527] [135/171] (881s left) prime_self_import (basic-llseek-size) [124.096947] Starting subtest: basic-llseek-size [124.099132] Subtest basic-llseek-size: SUCCESS (0.002s) [124.167176] [136/171] (881s left) prime_self_import (basic-with_fd_dup) [124.227610] Starting subtest: basic-with_fd_dup [124.229762] Subtest basic-with_fd_dup: SUCCESS (0.002s) [124.300601] [137/171] (880s left) prime_self_import (basic-with_one_bo) [124.359879] Starting subtest: basic-with_one_bo [124.363243] Subtest basic-with_one_bo: SUCCESS (0.003s) [124.413956] [138/171] (880s left) prime_self_import (basic-with_one_bo_two_files) [124.475885] Starting subtest: basic-with_one_bo_two_files [124.478236] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [124.550363] [139/171] (880s left) prime_self_import (basic-with_two_bos) [124.614305] Starting subtest: basic-with_two_bos [124.616412] Subtest basic-with_two_bos: SUCCESS (0.002s) [124.683544] [140/171] (880s left) prime_vgem (basic-fence-flip) [124.757395] Starting subtest: basic-fence-flip [125.085708] Subtest basic-fence-flip: SUCCESS (0.328s) [125.166893] [141/171] (880s left) prime_vgem (basic-fence-mmap) [125.239367] Starting subtest: basic-fence-mmap [125.261151] Subtest basic-fence-mmap: SUCCESS (0.022s) [125.336221] [142/171] (879s left) prime_vgem (basic-fence-read) [125.406429] Starting subtest: basic-fence-read [125.439746] Subtest basic-fence-read: SUCCESS (0.033s) [125.503417] [143/171] (879s left) prime_vgem (basic-gtt) [125.572374] Starting subtest: basic-gtt [125.584832] Subtest basic-gtt: SUCCESS (0.012s) [125.668802] [144/171] (879s left) prime_vgem (basic-read) [125.739466] Starting subtest: basic-read [125.755347] Subtest basic-read: SUCCESS (0.016s) [125.834021] [145/171] (879s left) prime_vgem (basic-write) [125.906171] Starting subtest: basic-write [125.923279] Subtest basic-write: SUCCESS (0.017s) [126.003144] [146/171] (879s left) vgem_basic (setversion) [126.070227] Starting subtest: setversion [126.072378] Subtest setversion: SUCCESS (0.000s) [126.118040] [147/171] (879s left) vgem_basic (create) [126.186447] Starting subtest: create [126.187620] Subtest create: SUCCESS (0.000s) [126.233825] [148/171] (879s left) vgem_basic (debugfs) [126.303192] Starting subtest: debugfs [126.304318] Subtest debugfs: SUCCESS (0.000s) [126.352806] [149/171] (879s left) vgem_basic (dmabuf-export) [126.420185] Starting subtest: dmabuf-export [126.422339] Subtest dmabuf-export: SUCCESS (0.002s) [126.500057] [150/171] (878s left) vgem_basic (dmabuf-fence) [126.570086] Starting subtest: dmabuf-fence [126.571132] Subtest dmabuf-fence: SUCCESS (0.001s) [126.617686] [151/171] (878s left) vgem_basic (dmabuf-fence-before) [126.686354] Starting subtest: dmabuf-fence-before [126.687385] Subtest dmabuf-fence-before: SUCCESS (0.000s) [126.733840] [152/171] (878s left) vgem_basic (dmabuf-mmap) [126.803050] Starting subtest: dmabuf-mmap [126.816730] Subtest dmabuf-mmap: SUCCESS (0.014s) [126.870799] [153/171] (878s left) vgem_basic (mmap) [126.936681] Starting subtest: mmap [126.946470] Subtest mmap: SUCCESS (0.010s) [126.985331] [154/171] (878s left) vgem_basic (second-client) [127.053033] Starting subtest: second-client [127.087169] Subtest second-client: SUCCESS (0.033s) [127.133835] [155/171] (878s left) vgem_basic (sysfs) [127.203012] Starting subtest: sysfs [127.204150] Subtest sysfs: SUCCESS (0.000s) [127.252896] [156/171] (878s left) core_hotunplug (unbind-rebind) [127.353480] Starting subtest: unbind-rebind [128.206196] Subtest unbind-rebind: SUCCESS (0.853s) [128.229782] [157/171] (877s left) vgem_basic (unload) [128.295717] Starting subtest: unload [157.173699] Subtest unload: SUCCESS (28.877s) [157.252084] [158/171] (848s left) i915_module_load (reload) [157.315914] Starting subtest: reload [159.305530] Subtest reload: SUCCESS (1.991s) [159.327505] [159/171] (846s left) gem_lmem_swapping (basic) [159.403578] Subtest basic: SKIP (0.000s) [159.430843] [160/171] (846s left) gem_lmem_swapping (parallel-random-engines) [159.495815] Subtest parallel-random-engines: SKIP (0.000s) [159.513660] [161/171] (846s left) gem_lmem_swapping (random-engines) [159.580035] Subtest random-engines: SKIP (0.000s) [159.600172] [162/171] (846s left) gem_lmem_swapping (verify-random) [159.666784] Subtest verify-random: SKIP (0.000s) [159.698459] [163/171] (845s left) i915_pm_rpm (module-reload) [161.529451] Starting subtest: module-reload [168.393633] Subtest module-reload: SUCCESS (6.864s) [168.407844] [164/171] (837s left) i915_selftest (live) [168.478131] Starting subtest: live [168.479358] Starting dynamic subtest: sanitycheck [169.050183] Dynamic subtest sanitycheck: SUCCESS (0.571s) [169.056771] Starting dynamic subtest: uncore [169.762379] Dynamic subtest uncore: SUCCESS (0.710s) [169.768605] Starting dynamic subtest: workarounds [170.450425] Dynamic subtest workarounds: SUCCESS (0.686s) [170.456381] Starting dynamic subtest: gt_engines [171.137572] Dynamic subtest gt_engines: SUCCESS (0.685s) [171.143891] Starting dynamic subtest: gt_timelines [176.894953] Dynamic subtest gt_timelines: SUCCESS (5.755s) [176.903855] Starting dynamic subtest: gt_contexts [177.609586] Dynamic subtest gt_contexts: SUCCESS (0.712s) [177.615221] Starting dynamic subtest: gt_lrc [178.145329] Dynamic subtest gt_lrc: SUCCESS (0.534s) [178.151331] Starting dynamic subtest: gt_mocs [178.664366] Dynamic subtest gt_mocs: SUCCESS (0.517s) [178.670269] Starting dynamic subtest: gt_pm [189.337348] Dynamic subtest gt_pm: SUCCESS (10.671s) [189.344149] Starting dynamic subtest: gt_heartbeat [190.018227] Dynamic subtest gt_heartbeat: SUCCESS (0.680s) [190.024749] Starting dynamic subtest: gt_tlb [190.553479] Dynamic subtest gt_tlb: SUCCESS (0.533s) [190.558879] Starting dynamic subtest: requests [196.900691] Dynamic subtest requests: SUCCESS (6.345s) [196.906549] Starting dynamic subtest: migrate [197.454895] Dynamic subtest migrate: SUCCESS (0.553s) [197.460797] Starting dynamic subtest: active [198.124344] Dynamic subtest active: SUCCESS (0.668s) [198.130214] Starting dynamic subtest: objects [199.182124] Dynamic subtest objects: SUCCESS (1.056s) [199.187977] Starting dynamic subtest: mman [203.111157] Dynamic subtest mman: SUCCESS (3.928s) [203.118049] Starting dynamic subtest: dmabuf [203.699032] Dynamic subtest dmabuf: SUCCESS (0.587s) [203.705655] Starting dynamic subtest: vma [204.415670] Dynamic subtest vma: SUCCESS (0.715s) [204.421334] Starting dynamic subtest: coherency [205.576660] Dynamic subtest coherency: SUCCESS (1.159s) [205.582268] Starting dynamic subtest: gtt [209.559955] Dynamic subtest gtt: SUCCESS (3.982s) [209.568993] Starting dynamic subtest: gem [210.461792] Dynamic subtest gem: SUCCESS (0.899s) [210.468385] Starting dynamic subtest: evict [211.107189] Dynamic subtest evict: SUCCESS (0.644s) [211.113747] Starting dynamic subtest: hugepages [212.242329] Dynamic subtest hugepages: SUCCESS (1.133s) [212.249467] Starting dynamic subtest: gem_contexts [217.037636] Dynamic subtest gem_contexts: SUCCESS (4.793s) [217.045240] Starting dynamic subtest: client [217.588225] Dynamic subtest client: SUCCESS (0.548s) [217.596224] Starting dynamic subtest: gem_migrate [218.120656] Dynamic subtest gem_migrate: SUCCESS (0.530s) [218.126595] Starting dynamic subtest: reset [219.806760] Dynamic subtest reset: SUCCESS (1.685s) [219.812653] Starting dynamic subtest: memory_region [220.348701] Dynamic subtest memory_region: SUCCESS (0.540s) [220.356087] Starting dynamic subtest: hangcheck [237.696299] Dynamic subtest hangcheck: SUCCESS (17.346s) [237.702330] Starting dynamic subtest: execlists [238.363041] Dynamic subtest execlists: SUCCESS (0.665s) [238.368987] Starting dynamic subtest: ring_submission [239.013808] Dynamic subtest ring_submission: SUCCESS (0.649s) [239.020140] Starting dynamic subtest: perf [239.759256] Dynamic subtest perf: SUCCESS (0.743s) [239.766551] Starting dynamic subtest: slpc [240.433093] Dynamic subtest slpc: SUCCESS (0.671s) [240.439084] Starting dynamic subtest: guc [241.060639] Dynamic subtest guc: SUCCESS (0.626s) [241.066786] Starting dynamic subtest: guc_multi_lrc [241.674732] Dynamic subtest guc_multi_lrc: SUCCESS (0.612s) [241.680452] Starting dynamic subtest: guc_hang [242.235352] Dynamic subtest guc_hang: SUCCESS (0.559s) [242.242270] Starting dynamic subtest: late_gt_pm [242.798361] Dynamic subtest late_gt_pm: SUCCESS (0.561s) [242.799425] Subtest live: SUCCESS (74.321s) [242.946704] [165/171] (762s left) dmabuf (all-tests) [243.013363] Starting subtest: all-tests [243.016874] Starting dynamic subtest: sanitycheck [243.078755] Dynamic subtest sanitycheck: SUCCESS (0.064s) [243.085222] Starting dynamic subtest: dma_fence [243.252692] Dynamic subtest dma_fence: SUCCESS (0.173s) [243.259100] Starting dynamic subtest: dma_fence_chain [254.534153] Dynamic subtest dma_fence_chain: SUCCESS (11.280s) [254.542360] Starting dynamic subtest: dma_fence_unwrap [254.603327] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s) [254.613097] Starting dynamic subtest: dma_resv [254.668070] Dynamic subtest dma_resv: SUCCESS (0.063s) [254.669158] Subtest all-tests: SUCCESS (11.655s) [254.681888] [166/171] (751s left) i915_suspend (basic-s2idle-without-i915) [254.744647] Starting subtest: basic-s2idle-without-i915 [272.791292] Subtest basic-s2idle-without-i915: SUCCESS (2.123s) [278.927285] [167/171] (748s left) i915_suspend (basic-s3-without-i915) [278.999095] Starting subtest: basic-s3-without-i915 [298.001796] Subtest basic-s3-without-i915: SUCCESS (2.291s) [298.108076] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1633 [max: 8192] direct dependencies: 16478 [max: 32768] indirect dependencies: 104351 all direct dependencies: 281134 dependency chains: 23273 [max: 131072] dependency chain hlocks used: 97176 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 144 in-softirq chains: 630 in-process chains: 22499 stack-trace entries: 231773 [max: 1048576] number of stack traces: 11142 number of stack hash chains: 8102 combined max dependencies: 2058637500 hardirq-safe locks: 73 hardirq-unsafe locks: 973 softirq-safe locks: 184 softirq-unsafe locks: 885 irq-safe locks: 199 irq-unsafe locks: 973 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 295 softirq-read-safe locks: 8 softirq-read-unsafe locks: 290 irq-read-safe locks: 8 irq-read-unsafe locks: 295 uncategorized locks: 277 unused locks: 1 max locking depth: 16 max bfs queue depth: 387 max lock class index: 1724 chain lookup misses: 61865 chain lookup hits: 401359544 cyclic checks: 61372 redundant checks: 0 redundant links: 0 find-mask forwards checks: 11299 find-mask backwards checks: 8560 hardirq on events: 251096613 hardirq off events: 251096607 redundant hardirq ons: 42 redundant hardirq offs: 24 softirq on events: 2096142 softirq off events: 2096143 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 4600 zapped lock chains: 38445 large chain blocks: 1 [298.109130] Closing watchdogs Done.