[26.432284] Initializing watchdogs [26.432365] /dev/watchdog0 [26.447666] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [26.454946] [001/162] (960s left) i915_module_load (load) [26.528944] Starting subtest: load [28.514171] Subtest load: SUCCESS (1.991s) [28.551010] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [28.552207] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [28.557180] [002/162] (958s left) core_auth (basic-auth) [28.620105] Starting subtest: basic-auth [28.623427] Subtest basic-auth: SUCCESS (0.001s) [28.664352] [003/162] (958s left) core_debugfs (read-all-entries) [28.710650] Starting subtest: read-all-entries [28.714115] Subtest read-all-entries: SUCCESS (0.002s) [28.753615] [004/162] (958s left) core_sysfs (read-all-entries) [28.799765] Starting subtest: read-all-entries [28.802882] Subtest read-all-entries: SUCCESS (0.003s) [28.842339] [005/162] (958s left) fbdev (eof) [28.897555] Subtest eof: SKIP (0.000s) [28.936345] [006/162] (958s left) fbdev (info) [28.990185] Subtest info: SKIP (0.000s) [29.028827] [007/162] (958s left) fbdev (nullptr) [29.079204] Subtest nullptr: SKIP (0.000s) [29.119945] [008/162] (958s left) fbdev (read) [29.174274] Subtest read: SKIP (0.000s) [29.215361] [009/162] (958s left) fbdev (write) [29.270298] Subtest write: SKIP (0.000s) [29.308693] [010/162] (958s left) gem_basic (bad-close) [29.358395] Starting subtest: bad-close [29.365090] Subtest bad-close: SUCCESS (0.000s) [29.403844] [011/162] (957s left) gem_basic (create-close) [29.453312] Starting subtest: create-close [29.459863] Subtest create-close: SUCCESS (0.000s) [29.507980] [012/162] (957s left) gem_basic (create-fd-close) [29.557194] Starting subtest: create-fd-close [29.563475] Subtest create-fd-close: SUCCESS (0.000s) [29.625150] [013/162] (957s left) gem_busy (busy@all-engines) [29.684942] Starting subtest: busy [29.687973] Starting dynamic subtest: all-engines [29.711597] Dynamic subtest all-engines: SUCCESS (0.026s) [29.714734] Subtest busy: SUCCESS (0.027s) [30.033683] [014/162] (957s left) gem_close_race (basic-process) [30.094488] Starting subtest: basic-process [30.148460] Subtest basic-process: SUCCESS (0.054s) [30.298330] [015/162] (957s left) gem_close_race (basic-threads) [30.353654] Starting subtest: basic-threads [31.590726] Subtest basic-threads: SUCCESS (1.237s) [31.743985] [016/162] (955s left) gem_ctx_create (basic) [31.801720] Starting subtest: basic [31.805102] Subtest basic: SUCCESS (0.000s) [31.949386] [017/162] (955s left) gem_ctx_create (basic-files) [32.003620] Starting subtest: basic-files [34.015134] Subtest basic-files: SUCCESS (2.012s) [34.208042] [018/162] (953s left) gem_ctx_exec (basic) [34.256859] Starting subtest: basic [34.260053] Subtest basic: SUCCESS (0.004s) [34.330623] [019/162] (953s left) gem_exec_basic (basic) [34.385161] Starting subtest: basic [34.388125] Starting dynamic subtest: rcs0-smem [34.391234] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [34.401668] Starting dynamic subtest: bcs0-smem [34.404694] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [34.414853] Starting dynamic subtest: vcs0-smem [34.417958] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [34.428082] Starting dynamic subtest: vecs0-smem [34.431127] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [34.434321] Subtest basic: SUCCESS (0.006s) [34.560360] [020/162] (953s left) gem_exec_create (basic) [34.617407] Starting subtest: basic [34.620535] Starting dynamic subtest: smem [36.669365] Dynamic subtest smem: SUCCESS (2.052s) [36.672465] Subtest basic: SUCCESS (2.052s) [36.816205] [021/162] (950s left) gem_exec_fence (basic-busy) [36.991166] Starting subtest: basic-busy [36.994489] Starting dynamic subtest: rcs0 [37.030285] Dynamic subtest rcs0: SUCCESS (0.039s) [37.045487] Starting dynamic subtest: bcs0 [37.073294] Dynamic subtest bcs0: SUCCESS (0.043s) [37.087148] Starting dynamic subtest: vcs0 [37.098172] Dynamic subtest vcs0: SUCCESS (0.025s) [37.109049] Starting dynamic subtest: vecs0 [37.132244] Dynamic subtest vecs0: SUCCESS (0.034s) [37.135568] Subtest basic-busy: SUCCESS (0.142s) [37.653258] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [37.657301] [022/162] (950s left) gem_exec_fence (basic-wait) [37.825734] Starting subtest: basic-wait [37.828951] Starting dynamic subtest: rcs0 [37.858453] Dynamic subtest rcs0: SUCCESS (0.032s) [37.875803] Starting dynamic subtest: bcs0 [37.891532] Dynamic subtest bcs0: SUCCESS (0.033s) [37.909147] Starting dynamic subtest: vcs0 [37.929816] Dynamic subtest vcs0: SUCCESS (0.038s) [37.952940] Starting dynamic subtest: vecs0 [37.972421] Dynamic subtest vecs0: SUCCESS (0.042s) [37.975620] Subtest basic-wait: SUCCESS (0.147s) [38.464098] [023/162] (949s left) gem_exec_fence (basic-await) [38.637534] Starting subtest: basic-await [38.641093] Starting dynamic subtest: rcs0 [38.720090] Dynamic subtest rcs0: SUCCESS (0.082s) [38.736694] Starting dynamic subtest: bcs0 [38.805487] Dynamic subtest bcs0: SUCCESS (0.085s) [38.828330] Starting dynamic subtest: vcs0 [38.897531] Dynamic subtest vcs0: SUCCESS (0.092s) [38.916297] Starting dynamic subtest: vecs0 [38.985623] Dynamic subtest vecs0: SUCCESS (0.088s) [38.989267] Subtest basic-await: SUCCESS (0.349s) [39.501415] [024/162] (948s left) gem_exec_fence (nb-await) [39.676236] Starting subtest: nb-await [39.679346] Starting dynamic subtest: rcs0 [39.739114] Dynamic subtest rcs0: SUCCESS (0.066s) [39.753745] Starting dynamic subtest: bcs0 [39.801380] Dynamic subtest bcs0: SUCCESS (0.062s) [39.823738] Starting dynamic subtest: vcs0 [39.866202] Dynamic subtest vcs0: SUCCESS (0.064s) [39.889261] Starting dynamic subtest: vecs0 [39.932461] Dynamic subtest vecs0: SUCCESS (0.066s) [39.935965] Subtest nb-await: SUCCESS (0.260s) [40.429654] [025/162] (947s left) gem_exec_gttfill (basic) [40.490511] Starting subtest: basic [43.958514] Subtest basic: SUCCESS (3.471s) [44.121283] [026/162] (943s left) gem_exec_parallel (engines) [44.270866] Starting subtest: engines [44.274052] Starting dynamic subtest: basic [45.970823] Dynamic subtest basic: SUCCESS (1.702s) [45.982833] Starting dynamic subtest: contexts [48.055092] Dynamic subtest contexts: SUCCESS (2.051s) [48.067185] Starting dynamic subtest: fds [49.978819] Dynamic subtest fds: SUCCESS (1.896s) [49.991115] Starting dynamic subtest: userptr [51.891350] Dynamic subtest userptr: SUCCESS (1.891s) [51.894867] Subtest engines: SUCCESS (7.542s) [52.053546] [027/162] (936s left) gem_exec_store (basic) [52.122177] Starting subtest: basic [52.171506] Subtest basic: SUCCESS (0.053s) [52.317367] [028/162] (935s left) gem_flink_basic (bad-flink) [52.368252] Starting subtest: bad-flink [52.371186] Subtest bad-flink: SUCCESS (0.000s) [52.418574] [029/162] (935s left) gem_flink_basic (bad-open) [52.469846] Starting subtest: bad-open [52.473027] Subtest bad-open: SUCCESS (0.000s) [52.516774] [030/162] (935s left) gem_flink_basic (basic) [52.565236] Starting subtest: basic [52.568240] Subtest basic: SUCCESS (0.000s) [52.620432] [031/162] (935s left) gem_flink_basic (double-flink) [52.669744] Starting subtest: double-flink [52.673044] Subtest double-flink: SUCCESS (0.000s) [52.728810] [032/162] (935s left) gem_flink_basic (flink-lifetime) [52.774742] Starting subtest: flink-lifetime [52.777813] Subtest flink-lifetime: SUCCESS (0.001s) [52.848323] [033/162] (935s left) gem_huc_copy (huc-copy) [52.901197] Starting subtest: huc-copy [52.907628] Subtest huc-copy: SKIP (0.000s) [52.966837] [034/162] (935s left) gem_linear_blits (basic) [53.097768] Starting subtest: basic [53.106562] Subtest basic: SUCCESS (0.008s) [53.198667] [035/162] (935s left) gem_mmap (basic) [53.335821] Starting subtest: basic [53.351462] Subtest basic: SUCCESS (0.000s) [53.395871] [036/162] (935s left) gem_mmap_gtt (basic) [53.446772] Starting subtest: basic [53.450712] Subtest basic: SUCCESS (0.001s) [53.494879] [037/162] (935s left) gem_render_linear_blits (basic) [53.544394] Starting subtest: basic [53.571337] Subtest basic: SUCCESS (0.029s) [53.635855] [038/162] (934s left) gem_render_tiled_blits (basic) [53.690682] Starting subtest: basic [53.716340] Subtest basic: SUCCESS (0.029s) [53.773792] [039/162] (934s left) gem_ringfill (basic-all) [53.998696] Starting subtest: basic-all [55.141287] Subtest basic-all: SUCCESS (1.132s) [55.217619] [040/162] (933s left) gem_softpin (allocator-basic) [55.271113] Starting subtest: allocator-basic [55.367211] Subtest allocator-basic: SUCCESS (0.097s) [55.452902] [041/162] (933s left) gem_softpin (allocator-basic-reserve) [55.505560] Starting subtest: allocator-basic-reserve [55.602629] Subtest allocator-basic-reserve: SUCCESS (0.099s) [55.693216] [042/162] (933s left) gem_softpin (safe-alignment) [55.747446] Starting subtest: safe-alignment [55.775494] Subtest safe-alignment: SUCCESS (0.010s) [55.842589] [043/162] (932s left) gem_sync (basic-all) [55.919756] Starting subtest: basic-all [57.944188] Subtest basic-all: SUCCESS (2.034s) [58.096537] [044/162] (930s left) gem_sync (basic-each) [58.173987] Starting subtest: basic-each [60.285300] Subtest basic-each: SUCCESS (2.124s) [60.442046] [045/162] (928s left) gem_tiled_blits (basic) [60.553873] Starting subtest: basic [60.567512] Subtest basic: SUCCESS (0.016s) [60.652950] [046/162] (928s left) gem_tiled_fence_blits (basic) [60.848733] Starting subtest: basic [60.857593] Subtest basic: SUCCESS (0.008s) [60.949789] [047/162] (928s left) gem_tiled_pread_basic (basic) [61.088391] Starting subtest: basic [61.194168] Subtest basic: SUCCESS (0.109s) [61.256531] [048/162] (927s left) gem_wait (busy@all-engines) [61.322457] Starting subtest: busy [61.325925] Starting dynamic subtest: all-engines [61.850523] Dynamic subtest all-engines: SUCCESS (0.527s) [61.853851] Subtest busy: SUCCESS (0.527s) [62.010600] [049/162] (927s left) gem_wait (wait@all-engines) [62.069519] Starting subtest: wait [62.072724] Starting dynamic subtest: all-engines [63.092043] Dynamic subtest all-engines: SUCCESS (1.020s) [63.095087] Subtest wait: SUCCESS (1.021s) [63.254911] [050/162] (925s left) i915_getparams_basic (basic-eu-total) [63.303439] Starting subtest: basic-eu-total [63.309426] Subtest basic-eu-total: SUCCESS (0.000s) [63.353337] [051/162] (925s left) i915_getparams_basic (basic-subslice-total) [63.403579] Starting subtest: basic-subslice-total [63.409530] Subtest basic-subslice-total: SUCCESS (0.000s) [63.453420] [052/162] (925s left) i915_hangman (error-state-basic) [63.509501] Starting subtest: error-state-basic [63.517935] Subtest error-state-basic: SUCCESS (0.005s) [63.587074] [053/162] (925s left) i915_pciid [63.685546] [054/162] (925s left) intel_hwmon (hwmon-read) [63.734148] Subtest hwmon-read: SKIP (0.000s) [63.778563] [055/162] (925s left) intel_hwmon (hwmon-write) [63.830189] Subtest hwmon-write: SKIP (0.000s) [63.874809] [056/162] (925s left) kms_addfb_basic (addfb25-4-tiled) [63.960058] Starting subtest: addfb25-4-tiled [63.963172] Subtest addfb25-4-tiled: SUCCESS (0.000s) [64.020127] [057/162] (925s left) kms_addfb_basic (addfb25-bad-modifier) [64.097649] Starting subtest: addfb25-bad-modifier [64.100844] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [64.151986] [058/162] (925s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [64.233168] Starting subtest: addfb25-framebuffer-vs-set-tiling [64.236232] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [64.304308] [059/162] (925s left) kms_addfb_basic (addfb25-modifier-no-flag) [64.386446] Starting subtest: addfb25-modifier-no-flag [64.389675] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [64.449801] [060/162] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy) [64.533087] Starting subtest: addfb25-x-tiled-legacy [64.536229] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [64.602496] [061/162] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [64.680110] Starting subtest: addfb25-x-tiled-mismatch-legacy [64.683202] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [64.747354] [062/162] (924s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [64.825450] Starting subtest: addfb25-yf-tiled-legacy [64.828496] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [64.883889] [063/162] (924s left) kms_addfb_basic (addfb25-y-tiled-legacy) [64.963495] Starting subtest: addfb25-y-tiled-legacy [64.966587] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [65.029619] [064/162] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [65.110635] Starting subtest: addfb25-y-tiled-small-legacy [65.113662] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [65.170194] [065/162] (924s left) kms_addfb_basic (bad-pitch-0) [65.222282] Starting subtest: bad-pitch-0 [65.226222] Subtest bad-pitch-0: SUCCESS (0.000s) [65.313596] [066/162] (924s left) kms_addfb_basic (bad-pitch-1024) [65.367604] Starting subtest: bad-pitch-1024 [65.371250] Subtest bad-pitch-1024: SUCCESS (0.000s) [65.455334] [067/162] (924s left) kms_addfb_basic (bad-pitch-128) [65.508432] Starting subtest: bad-pitch-128 [65.511939] Subtest bad-pitch-128: SUCCESS (0.000s) [65.731939] [068/162] (924s left) kms_addfb_basic (bad-pitch-256) [66.084182] Starting subtest: bad-pitch-256 [66.148269] Subtest bad-pitch-256: SUCCESS (0.000s) [66.562548] [069/162] (923s left) kms_addfb_basic (bad-pitch-32) [66.889288] Starting subtest: bad-pitch-32 [67.042474] Subtest bad-pitch-32: SUCCESS (0.000s) [67.096457] [070/162] (923s left) kms_addfb_basic (bad-pitch-63) [67.177653] Starting subtest: bad-pitch-63 [67.181961] Subtest bad-pitch-63: SUCCESS (0.000s) [67.428606] [071/162] (923s left) kms_addfb_basic (bad-pitch-65536) [67.490178] Starting subtest: bad-pitch-65536 [67.493424] Subtest bad-pitch-65536: SUCCESS (0.000s) [67.582692] [072/162] (923s left) kms_addfb_basic (bad-pitch-999) [67.636859] Starting subtest: bad-pitch-999 [67.639848] Subtest bad-pitch-999: SUCCESS (0.000s) [67.727363] [073/162] (923s left) kms_addfb_basic (basic) [67.778758] Starting subtest: basic [67.782906] Subtest basic: SUCCESS (0.000s) [67.874090] [074/162] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [67.926152] Starting subtest: basic-x-tiled-legacy [67.929918] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [68.011248] [075/162] (922s left) kms_addfb_basic (basic-y-tiled-legacy) [68.063231] Starting subtest: basic-y-tiled-legacy [68.067093] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [68.151790] [076/162] (922s left) kms_addfb_basic (bo-too-small) [68.227823] Starting subtest: bo-too-small [68.230983] Subtest bo-too-small: SUCCESS (0.000s) [68.292984] [077/162] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling) [68.371888] Starting subtest: bo-too-small-due-to-tiling [68.375112] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [68.429233] [078/162] (922s left) kms_addfb_basic (clobberred-modifier) [68.480480] Starting subtest: clobberred-modifier [68.484302] Subtest clobberred-modifier: SUCCESS (0.000s) [68.571126] [079/162] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling) [68.622627] Starting subtest: framebuffer-vs-set-tiling [68.626507] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [68.712340] [080/162] (922s left) kms_addfb_basic (invalid-get-prop) [68.763257] Starting subtest: invalid-get-prop [68.766979] Subtest invalid-get-prop: SUCCESS (0.000s) [68.852434] [081/162] (922s left) kms_addfb_basic (invalid-get-prop-any) [68.904343] Starting subtest: invalid-get-prop-any [68.907670] Subtest invalid-get-prop-any: SUCCESS (0.000s) [68.986745] [082/162] (922s left) kms_addfb_basic (invalid-set-prop) [69.035536] Starting subtest: invalid-set-prop [69.039916] Subtest invalid-set-prop: SUCCESS (0.000s) [69.132438] [083/162] (922s left) kms_addfb_basic (invalid-set-prop-any) [69.182625] Starting subtest: invalid-set-prop-any [69.186982] Subtest invalid-set-prop-any: SUCCESS (0.000s) [69.278906] [084/162] (921s left) kms_addfb_basic (no-handle) [69.328912] Starting subtest: no-handle [69.333241] Subtest no-handle: SUCCESS (0.000s) [69.422389] [085/162] (921s left) kms_addfb_basic (size-max) [69.499457] Starting subtest: size-max [69.502621] Subtest size-max: SUCCESS (0.000s) [69.566608] [086/162] (921s left) kms_addfb_basic (small-bo) [69.647912] Starting subtest: small-bo [69.651095] Subtest small-bo: SUCCESS (0.000s) [69.712518] [087/162] (921s left) kms_addfb_basic (tile-pitch-mismatch) [69.770569] Starting subtest: tile-pitch-mismatch [69.774228] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [69.851123] [088/162] (921s left) kms_addfb_basic (too-high) [69.932443] Starting subtest: too-high [69.935601] Subtest too-high: SUCCESS (0.001s) [69.991117] [089/162] (921s left) kms_addfb_basic (too-wide) [70.068159] Starting subtest: too-wide [70.071333] Subtest too-wide: SUCCESS (0.000s) [70.130378] [090/162] (921s left) kms_addfb_basic (unused-handle) [70.180698] Starting subtest: unused-handle [70.185206] Subtest unused-handle: SUCCESS (0.000s) [70.276569] [091/162] (921s left) kms_addfb_basic (unused-modifier) [70.327756] Starting subtest: unused-modifier [70.331083] Subtest unused-modifier: SUCCESS (0.000s) [70.422175] [092/162] (921s left) kms_addfb_basic (unused-offsets) [70.474553] Starting subtest: unused-offsets [70.477877] Subtest unused-offsets: SUCCESS (0.000s) [70.565276] [093/162] (921s left) kms_addfb_basic (unused-pitches) [70.615866] Starting subtest: unused-pitches [70.619763] Subtest unused-pitches: SUCCESS (0.000s) [70.706769] [094/162] (921s left) kms_busy (basic) [70.790284] Subtest basic: SKIP (0.000s) [70.834736] [095/162] (920s left) kms_prop_blob (basic) [70.885379] Starting subtest: basic [70.888632] Subtest basic: SUCCESS (0.000s) [70.932024] [096/162] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [71.033957] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [71.079277] [097/162] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [71.179535] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [71.226330] [098/162] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [71.324168] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [71.370284] [099/162] (920s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [71.478770] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [71.541527] [100/162] (920s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [71.643429] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [71.689347] [101/162] (920s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [71.793333] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [71.851128] [102/162] (920s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [71.950616] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [72.000901] [103/162] (920s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [72.099715] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [72.148568] [104/162] (920s left) kms_dsc (dsc-basic) [72.235705] Subtest dsc-basic: SKIP (0.000s) [72.278885] [105/162] (919s left) kms_flip (basic-flip-vs-dpms) [72.361222] Starting subtest: basic-flip-vs-dpms [72.366894] Subtest basic-flip-vs-dpms: SKIP (0.001s) [72.433184] [106/162] (919s left) kms_flip (basic-flip-vs-modeset) [72.514857] Starting subtest: basic-flip-vs-modeset [72.520969] Subtest basic-flip-vs-modeset: SKIP (0.001s) [72.588475] [107/162] (919s left) kms_flip (basic-flip-vs-wf_vblank) [72.669318] Starting subtest: basic-flip-vs-wf_vblank [72.676339] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [72.720196] [108/162] (919s left) kms_flip (basic-plain-flip) [72.803317] Starting subtest: basic-plain-flip [72.809913] Subtest basic-plain-flip: SKIP (0.001s) [72.853455] [109/162] (919s left) kms_force_connector_basic (force-connector-state) [73.009655] Starting subtest: force-connector-state [73.092122] Subtest force-connector-state: SUCCESS (0.080s) [73.266201] [110/162] (919s left) kms_force_connector_basic (force-edid) [73.425854] Starting subtest: force-edid [73.601493] Subtest force-edid: SUCCESS (0.181s) [73.691269] [111/162] (918s left) kms_force_connector_basic (force-load-detect) [73.851023] Starting subtest: force-load-detect [73.857414] Subtest force-load-detect: SKIP (0.000s) [73.923749] [112/162] (918s left) kms_force_connector_basic (prune-stale-modes) [74.082592] Starting subtest: prune-stale-modes [74.277566] Subtest prune-stale-modes: SUCCESS (0.194s) [74.361204] [113/162] (918s left) kms_frontbuffer_tracking (basic) [74.448221] Subtest basic: SKIP (0.000s) [74.501891] [114/162] (918s left) kms_hdmi_inject (inject-audio) [74.552484] Starting subtest: inject-audio [74.558680] Subtest inject-audio: SKIP (0.000s) [74.702052] [115/162] (918s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [75.218029] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [75.633985] [116/162] (917s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [76.079963] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [76.127992] [117/162] (917s left) kms_pipe_crc_basic (hang-read-crc) [76.208855] Subtest hang-read-crc: SKIP (0.000s) [76.253436] [118/162] (917s left) kms_pipe_crc_basic (nonblocking-crc) [76.335095] Subtest nonblocking-crc: SKIP (0.000s) [76.379352] [119/162] (917s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [76.463367] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [76.506714] [120/162] (917s left) kms_pipe_crc_basic (read-crc) [76.589056] Subtest read-crc: SKIP (0.000s) [76.633441] [121/162] (917s left) kms_pipe_crc_basic (read-crc-frame-sequence) [76.710477] Subtest read-crc-frame-sequence: SKIP (0.000s) [76.753375] [122/162] (916s left) kms_pm_backlight (basic-brightness) [76.833689] Subtest basic-brightness: SKIP (0.000s) [76.877730] [123/162] (916s left) kms_pm_rpm (basic-pci-d3-state) [88.183695] Starting subtest: basic-pci-d3-state [88.371737] Subtest basic-pci-d3-state: SUCCESS (0.188s) [88.429062] [124/162] (905s left) kms_pm_rpm (basic-rte) [88.480888] Starting subtest: basic-rte [100.007069] Subtest basic-rte: SUCCESS (11.526s) [100.308434] [125/162] (893s left) kms_psr (psr-primary-page-flip) [100.390498] Subtest psr-primary-page-flip: SKIP (0.000s) [100.435439] [126/162] (893s left) kms_psr (psr-cursor-plane-move) [100.519478] Subtest psr-cursor-plane-move: SKIP (0.000s) [100.564633] [127/162] (893s left) kms_psr (psr-sprite-plane-onoff) [100.645555] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [100.690687] [128/162] (893s left) kms_psr (psr-primary-mmap-gtt) [100.776170] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [100.820952] [129/162] (893s left) kms_setmode (basic-clone-single-crtc) [100.872942] Starting subtest: basic-clone-single-crtc [100.882450] Subtest basic-clone-single-crtc: SKIP (0.000s) [100.941685] [130/162] (893s left) i915_pm_rps (basic-api) [100.997611] Starting subtest: basic-api [101.000793] Subtest basic-api: SUCCESS (0.003s) [101.049424] [131/162] (893s left) prime_self_import (basic-llseek-bad) [101.098577] Starting subtest: basic-llseek-bad [101.105060] Subtest basic-llseek-bad: SUCCESS (0.002s) [101.169816] [132/162] (893s left) prime_self_import (basic-llseek-size) [101.215972] Starting subtest: basic-llseek-size [101.222405] Subtest basic-llseek-size: SUCCESS (0.002s) [101.284810] [133/162] (892s left) prime_self_import (basic-with_fd_dup) [101.331451] Starting subtest: basic-with_fd_dup [101.337763] Subtest basic-with_fd_dup: SUCCESS (0.003s) [101.397920] [134/162] (892s left) prime_self_import (basic-with_one_bo) [101.444414] Starting subtest: basic-with_one_bo [101.450592] Subtest basic-with_one_bo: SUCCESS (0.002s) [101.496067] [135/162] (892s left) prime_self_import (basic-with_one_bo_two_files) [101.543492] Starting subtest: basic-with_one_bo_two_files [101.549430] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [101.612706] [136/162] (892s left) prime_self_import (basic-with_two_bos) [101.660459] Starting subtest: basic-with_two_bos [101.666857] Subtest basic-with_two_bos: SUCCESS (0.002s) [101.729365] [137/162] (892s left) prime_vgem (basic-fence-flip) [101.782616] Starting subtest: basic-fence-flip [101.844789] Subtest basic-fence-flip: SKIP (0.057s) [101.893293] [138/162] (892s left) prime_vgem (basic-fence-mmap) [101.948343] Starting subtest: basic-fence-mmap [101.970101] Subtest basic-fence-mmap: SUCCESS (0.023s) [102.046668] [139/162] (892s left) prime_vgem (basic-fence-read) [102.104501] Starting subtest: basic-fence-read [102.148963] Subtest basic-fence-read: SUCCESS (0.046s) [102.223680] [140/162] (892s left) prime_vgem (basic-gtt) [102.279903] Starting subtest: basic-gtt [102.287579] Subtest basic-gtt: SUCCESS (0.012s) [102.369147] [141/162] (892s left) prime_vgem (basic-read) [102.425168] Starting subtest: basic-read [102.443427] Subtest basic-read: SUCCESS (0.023s) [102.510767] [142/162] (892s left) prime_vgem (basic-write) [102.565737] Starting subtest: basic-write [102.583205] Subtest basic-write: SUCCESS (0.022s) [102.655774] [143/162] (892s left) vgem_basic (setversion) [102.708697] Starting subtest: setversion [102.714983] Subtest setversion: SUCCESS (0.000s) [102.765499] [144/162] (892s left) vgem_basic (create) [102.818084] Starting subtest: create [102.930514] Subtest create: FAIL (0.060s) [102.974991] [145/162] (891s left) vgem_basic (debugfs) [103.027169] Starting subtest: debugfs [103.030312] Subtest debugfs: SUCCESS (0.000s) [103.081356] [146/162] (891s left) vgem_basic (dmabuf-export) [103.133863] Starting subtest: dmabuf-export [103.139893] Subtest dmabuf-export: SUCCESS (0.002s) [103.201927] [147/162] (891s left) vgem_basic (dmabuf-fence) [103.250773] Starting subtest: dmabuf-fence [103.254059] Subtest dmabuf-fence: SUCCESS (0.001s) [103.299352] [148/162] (891s left) vgem_basic (dmabuf-fence-before) [103.352657] Starting subtest: dmabuf-fence-before [103.356629] Subtest dmabuf-fence-before: SUCCESS (0.000s) [103.406865] [149/162] (891s left) vgem_basic (dmabuf-mmap) [103.455955] Starting subtest: dmabuf-mmap [103.462617] Subtest dmabuf-mmap: SUCCESS (0.009s) [103.507856] [150/162] (891s left) vgem_basic (mmap) [103.564457] Starting subtest: mmap [103.568375] Subtest mmap: SUCCESS (0.009s) [103.620183] [151/162] (891s left) vgem_basic (second-client) [103.674170] Starting subtest: second-client [103.680598] Subtest second-client: SUCCESS (0.002s) [103.731343] [152/162] (891s left) vgem_basic (sysfs) [103.783336] Starting subtest: sysfs [103.786614] Subtest sysfs: SUCCESS (0.001s) [103.836958] [153/162] (891s left) core_hotunplug (unbind-rebind) [103.948279] Starting subtest: unbind-rebind [107.388397] Subtest unbind-rebind: SUCCESS (3.440s) [107.433185] [154/162] (887s left) vgem_basic (unload) [107.481142] Starting subtest: unload [136.331367] Subtest unload: SUCCESS (28.851s) [136.394465] [155/162] (858s left) i915_module_load (reload) [136.442279] Starting subtest: reload [138.851705] Subtest reload: SUCCESS (2.411s) [138.896408] [156/162] (856s left) gem_lmem_swapping (basic) [138.958248] Subtest basic: SKIP (0.000s) [139.004954] [157/162] (856s left) gem_lmem_swapping (parallel-random-engines) [139.059497] Subtest parallel-random-engines: SKIP (0.000s) [139.106173] [158/162] (856s left) gem_lmem_swapping (random-engines) [139.158486] Subtest random-engines: SKIP (0.000s) [139.205811] [159/162] (856s left) gem_lmem_swapping (verify-random) [139.259325] Subtest verify-random: SKIP (0.000s) [139.306800] [160/162] (856s left) i915_pm_rpm (module-reload) [150.587025] Starting subtest: module-reload [178.188992] Subtest module-reload: SUCCESS (27.606s) [178.221426] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [178.222439] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [178.226481] [161/162] (817s left) i915_selftest (live) [178.277486] Starting subtest: live [178.280749] Starting dynamic subtest: sanitycheck [180.384447] Dynamic subtest sanitycheck: SUCCESS (2.105s) [180.397352] Starting dynamic subtest: uncore [182.473199] Dynamic subtest uncore: SUCCESS (2.089s) [182.495490] Starting dynamic subtest: workarounds [184.762660] Dynamic subtest workarounds: SUCCESS (2.285s) [184.774255] Starting dynamic subtest: gt_engines [187.301364] Dynamic subtest gt_engines: SUCCESS (2.545s) [187.313341] Starting dynamic subtest: gt_timelines [196.030760] Dynamic subtest gt_timelines: SUCCESS (8.730s) [196.046507] Starting dynamic subtest: gt_contexts [198.312055] Dynamic subtest gt_contexts: SUCCESS (2.219s) [198.376544] Starting dynamic subtest: gt_lrc [202.810571] Dynamic subtest gt_lrc: SUCCESS (4.559s) [202.825879] Starting dynamic subtest: gt_mocs [205.043316] Dynamic subtest gt_mocs: SUCCESS (2.230s) [205.056258] Starting dynamic subtest: gt_pm [211.440766] Dynamic subtest gt_pm: SUCCESS (6.398s) [211.452570] Starting dynamic subtest: gt_heartbeat [213.552890] Dynamic subtest gt_heartbeat: SUCCESS (2.104s) [213.564587] Starting dynamic subtest: gt_tlb [216.889844] Dynamic subtest gt_tlb: SUCCESS (3.343s) [216.901733] Starting dynamic subtest: requests [225.240287] Dynamic subtest requests: SUCCESS (8.348s) [225.253196] Starting dynamic subtest: migrate [230.384785] Dynamic subtest migrate: SUCCESS (5.145s) [230.396295] Starting dynamic subtest: active [232.483082] Dynamic subtest active: SUCCESS (2.094s) [232.494755] Starting dynamic subtest: objects [235.124238] Dynamic subtest objects: SUCCESS (2.635s) [235.138220] Starting dynamic subtest: mman [240.345689] Dynamic subtest mman: SUCCESS (5.229s) [240.357585] Starting dynamic subtest: dmabuf [242.590089] Dynamic subtest dmabuf: SUCCESS (2.136s) [242.601403] Starting dynamic subtest: vma [244.595261] Dynamic subtest vma: SUCCESS (2.109s) [244.608175] Starting dynamic subtest: coherency [248.233463] Dynamic subtest coherency: SUCCESS (3.640s) [248.249561] Starting dynamic subtest: gtt [257.724791] Dynamic subtest gtt: SUCCESS (9.490s) [257.736396] Starting dynamic subtest: gem [259.955275] Dynamic subtest gem: SUCCESS (2.226s) [259.968226] Starting dynamic subtest: evict [263.277707] Dynamic subtest evict: SUCCESS (3.325s) [263.290009] Starting dynamic subtest: hugepages [271.887898] Dynamic subtest hugepages: SUCCESS (8.609s) [271.899802] Starting dynamic subtest: gem_contexts [286.614795] Dynamic subtest gem_contexts: SUCCESS (14.727s) [286.626615] Starting dynamic subtest: client [288.813928] Dynamic subtest client: SUCCESS (2.190s) [288.825943] Starting dynamic subtest: gem_migrate [290.915347] Dynamic subtest gem_migrate: SUCCESS (2.101s) [290.927381] Starting dynamic subtest: reset [293.242735] Dynamic subtest reset: SUCCESS (2.334s) [293.254762] Starting dynamic subtest: memory_region [295.384183] Dynamic subtest memory_region: SUCCESS (2.087s) [295.448327] Starting dynamic subtest: hangcheck [320.478895] Dynamic subtest hangcheck: SUCCESS (25.147s) [320.495541] Starting dynamic subtest: execlists [330.685212] Dynamic subtest execlists: SUCCESS (10.205s) [330.697402] Starting dynamic subtest: ring_submission [332.753402] Dynamic subtest ring_submission: SUCCESS (2.061s) [332.766207] Starting dynamic subtest: perf [334.973493] Dynamic subtest perf: SUCCESS (2.218s) [334.984844] Starting dynamic subtest: slpc [337.058368] Dynamic subtest slpc: SUCCESS (2.090s) [337.071390] Starting dynamic subtest: guc [339.153375] Dynamic subtest guc: SUCCESS (2.090s) [339.165097] Starting dynamic subtest: guc_multi_lrc [341.223550] Dynamic subtest guc_multi_lrc: SUCCESS (2.074s) [341.235015] Starting dynamic subtest: guc_hang [343.323558] Dynamic subtest guc_hang: SUCCESS (2.091s) [343.337534] Starting dynamic subtest: late_gt_pm [345.453708] Dynamic subtest late_gt_pm: SUCCESS (2.134s) [345.457070] Subtest live: SUCCESS (167.175s) [345.494442] [162/162] (650s left) dmabuf (all-tests) [345.549710] Starting subtest: all-tests [345.555708] Subtest all-tests: SKIP (0.000s) [345.591683] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.