[36.175671] Initializing watchdogs [36.175778] /dev/watchdog0 [36.198786] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [36.205496] [001/162] (960s left) i915_module_load (load) [36.269292] Starting subtest: load [38.489746] Subtest load: SUCCESS (2.221s) [38.530452] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [38.532764] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [38.536140] [002/162] (958s left) core_auth (basic-auth) [38.606207] Starting subtest: basic-auth [38.607168] Subtest basic-auth: SUCCESS (0.001s) [38.651665] [003/162] (958s left) core_debugfs (read-all-entries) [38.707890] Starting subtest: read-all-entries [38.710620] Subtest read-all-entries: SUCCESS (0.003s) [38.756543] [004/162] (958s left) core_sysfs (read-all-entries) [38.813735] Starting subtest: read-all-entries [38.817315] Subtest read-all-entries: SUCCESS (0.004s) [38.862981] [005/162] (958s left) fbdev (eof) [38.929021] Subtest eof: SKIP (0.000s) [38.972766] [006/162] (957s left) fbdev (info) [39.038280] Subtest info: SKIP (0.000s) [39.100321] [007/162] (957s left) fbdev (nullptr) [39.164885] Subtest nullptr: SKIP (0.000s) [39.208354] [008/162] (957s left) fbdev (read) [39.272759] Subtest read: SKIP (0.000s) [39.315651] [009/162] (957s left) fbdev (write) [39.382806] Subtest write: SKIP (0.000s) [39.426802] [010/162] (957s left) gem_basic (bad-close) [39.481941] Starting subtest: bad-close [39.483782] Subtest bad-close: SUCCESS (0.000s) [39.529198] [011/162] (957s left) gem_basic (create-close) [39.583773] Starting subtest: create-close [39.585510] Subtest create-close: SUCCESS (0.000s) [39.645721] [012/162] (957s left) gem_basic (create-fd-close) [39.700616] Starting subtest: create-fd-close [39.703375] Subtest create-fd-close: SUCCESS (0.000s) [39.767565] [013/162] (957s left) gem_busy (busy@all-engines) [39.844488] Starting subtest: busy [39.845443] Starting dynamic subtest: all-engines [39.911088] Dynamic subtest all-engines: SUCCESS (0.067s) [39.912840] Subtest busy: SUCCESS (0.068s) [40.320994] [014/162] (957s left) gem_close_race (basic-process) [40.403605] Starting subtest: basic-process [40.479316] Subtest basic-process: SUCCESS (0.076s) [40.718224] [015/162] (956s left) gem_close_race (basic-threads) [40.799470] Starting subtest: basic-threads [42.014993] Subtest basic-threads: SUCCESS (1.216s) [42.223556] [016/162] (955s left) gem_ctx_create (basic) [42.299713] Starting subtest: basic [42.300939] Subtest basic: SUCCESS (0.000s) [42.484888] [017/162] (955s left) gem_ctx_create (basic-files) [42.627697] Starting subtest: basic-files [44.576366] Subtest basic-files: SUCCESS (2.017s) [44.816710] [018/162] (952s left) gem_ctx_exec (basic) [44.923409] Starting subtest: basic [44.929918] Subtest basic: SUCCESS (0.006s) [45.042778] [019/162] (952s left) gem_exec_basic (basic) [45.107237] Starting subtest: basic [45.108217] Starting dynamic subtest: rcs0-smem [45.111260] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [45.121587] Starting dynamic subtest: bcs0-smem [45.122462] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [45.131468] Starting dynamic subtest: vcs0-smem [45.132610] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [45.141384] Starting dynamic subtest: vcs1-smem [45.142514] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [45.151353] Starting dynamic subtest: vecs0-smem [45.152509] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [45.153597] Subtest basic: SUCCESS (0.011s) [45.345134] [020/162] (952s left) gem_exec_create (basic) [45.416329] Starting subtest: basic [45.417272] Starting dynamic subtest: smem [47.519800] Dynamic subtest smem: SUCCESS (2.064s) [47.521461] Subtest basic: SUCCESS (2.065s) [47.663659] [021/162] (950s left) gem_exec_fence (basic-busy) [47.891788] Starting subtest: basic-busy [47.893082] Starting dynamic subtest: rcs0 [47.924409] Dynamic subtest rcs0: SUCCESS (0.034s) [47.933817] Starting dynamic subtest: bcs0 [47.950389] Dynamic subtest bcs0: SUCCESS (0.026s) [47.959918] Starting dynamic subtest: vcs0 [47.970344] Dynamic subtest vcs0: SUCCESS (0.020s) [47.979793] Starting dynamic subtest: vcs1 [47.990276] Dynamic subtest vcs1: SUCCESS (0.020s) [47.999781] Starting dynamic subtest: vecs0 [48.012427] Dynamic subtest vecs0: SUCCESS (0.022s) [48.013605] Subtest basic-busy: SUCCESS (0.122s) [48.716899] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [48.719753] [022/162] (949s left) gem_exec_fence (basic-wait) [48.942628] Starting subtest: basic-wait [48.944790] Starting dynamic subtest: rcs0 [48.969510] Dynamic subtest rcs0: SUCCESS (0.027s) [48.985029] Starting dynamic subtest: bcs0 [49.003694] Dynamic subtest bcs0: SUCCESS (0.033s) [49.014335] Starting dynamic subtest: vcs0 [49.041737] Dynamic subtest vcs0: SUCCESS (0.038s) [49.053371] Starting dynamic subtest: vcs1 [49.063510] Dynamic subtest vcs1: SUCCESS (0.021s) [49.075218] Starting dynamic subtest: vecs0 [49.086503] Dynamic subtest vecs0: SUCCESS (0.023s) [49.087700] Subtest basic-wait: SUCCESS (0.145s) [49.739172] [023/162] (948s left) gem_exec_fence (basic-await) [49.962329] Starting subtest: basic-await [49.963980] Starting dynamic subtest: rcs0 [50.073876] Dynamic subtest rcs0: SUCCESS (0.106s) [50.086631] Starting dynamic subtest: bcs0 [50.175896] Dynamic subtest bcs0: SUCCESS (0.108s) [50.186297] Starting dynamic subtest: vcs0 [50.279450] Dynamic subtest vcs0: SUCCESS (0.103s) [50.295402] Starting dynamic subtest: vcs1 [50.470360] Dynamic subtest vcs1: SUCCESS (0.135s) [50.489721] Starting dynamic subtest: vecs0 [50.548839] Dynamic subtest vecs0: SUCCESS (0.134s) [50.549928] Subtest basic-await: SUCCESS (0.588s) [51.245343] [024/162] (946s left) gem_exec_fence (nb-await) [51.463689] Starting subtest: nb-await [51.465230] Starting dynamic subtest: rcs0 [51.535443] Dynamic subtest rcs0: SUCCESS (0.071s) [51.553097] Starting dynamic subtest: bcs0 [51.607888] Dynamic subtest bcs0: SUCCESS (0.072s) [51.638669] Starting dynamic subtest: vcs0 [51.692143] Dynamic subtest vcs0: SUCCESS (0.081s) [51.719561] Starting dynamic subtest: vcs1 [51.772871] Dynamic subtest vcs1: SUCCESS (0.081s) [51.808183] Starting dynamic subtest: vecs0 [51.865392] Dynamic subtest vecs0: SUCCESS (0.090s) [51.868186] Subtest nb-await: SUCCESS (0.402s) [52.557892] [025/162] (945s left) gem_exec_gttfill (basic) [52.638575] Starting subtest: basic [57.569945] Subtest basic: SUCCESS (4.937s) [57.827787] [026/162] (940s left) gem_exec_parallel (engines) [58.049453] Starting subtest: engines [58.050658] Starting dynamic subtest: basic [60.256275] Dynamic subtest basic: SUCCESS (2.239s) [60.267173] Starting dynamic subtest: contexts [65.732672] Dynamic subtest contexts: SUCCESS (5.518s) [65.743989] Starting dynamic subtest: fds [72.467483] Dynamic subtest fds: SUCCESS (6.695s) [72.478711] Starting dynamic subtest: userptr [75.385497] Dynamic subtest userptr: SUCCESS (2.917s) [75.387641] Subtest engines: SUCCESS (17.370s) [75.542824] [027/162] (922s left) gem_exec_store (basic) [75.621587] Starting subtest: basic [75.679881] Subtest basic: SUCCESS (0.059s) [75.865457] [028/162] (922s left) gem_flink_basic (bad-flink) [75.922802] Starting subtest: bad-flink [75.924067] Subtest bad-flink: SUCCESS (0.000s) [75.976335] [029/162] (922s left) gem_flink_basic (bad-open) [76.032119] Starting subtest: bad-open [76.033302] Subtest bad-open: SUCCESS (0.000s) [76.084231] [030/162] (922s left) gem_flink_basic (basic) [76.353375] Starting subtest: basic [76.355091] Subtest basic: SUCCESS (0.000s) [76.419996] [031/162] (922s left) gem_flink_basic (double-flink) [76.473367] Starting subtest: double-flink [76.474309] Subtest double-flink: SUCCESS (0.000s) [76.551159] [032/162] (922s left) gem_flink_basic (flink-lifetime) [76.604968] Starting subtest: flink-lifetime [76.607199] Subtest flink-lifetime: SUCCESS (0.002s) [76.674796] [033/162] (921s left) gem_huc_copy (huc-copy) [76.740479] Starting subtest: huc-copy [76.742423] Subtest huc-copy: SKIP (0.000s) [76.828133] [034/162] (921s left) gem_linear_blits (basic) [77.018880] Starting subtest: basic [77.030826] Subtest basic: SUCCESS (0.012s) [77.218799] [035/162] (921s left) gem_mmap (basic) [77.388730] Starting subtest: basic [77.393099] Subtest basic: SUCCESS (0.001s) [77.456880] [036/162] (921s left) gem_mmap_gtt (basic) [77.513787] Starting subtest: basic [77.514715] Subtest basic: SUCCESS (0.001s) [77.571705] [037/162] (921s left) gem_render_linear_blits (basic) [77.635196] Starting subtest: basic [77.671427] Subtest basic: SUCCESS (0.036s) [77.741516] [038/162] (921s left) gem_render_tiled_blits (basic) [77.809256] Starting subtest: basic [77.851929] Subtest basic: SUCCESS (0.043s) [77.918835] [039/162] (921s left) gem_ringfill (basic-all) [78.212462] Starting subtest: basic-all [79.455722] Subtest basic-all: SUCCESS (1.187s) [79.511329] [040/162] (919s left) gem_softpin (allocator-basic) [79.582146] Starting subtest: allocator-basic [79.779155] Subtest allocator-basic: SUCCESS (0.141s) [79.833104] [041/162] (919s left) gem_softpin (allocator-basic-reserve) [79.900350] Starting subtest: allocator-basic-reserve [80.040962] Subtest allocator-basic-reserve: SUCCESS (0.140s) [80.116133] [042/162] (919s left) gem_softpin (safe-alignment) [80.182883] Starting subtest: safe-alignment [80.200417] Subtest safe-alignment: SUCCESS (0.017s) [80.281776] [043/162] (918s left) gem_sync (basic-all) [80.361525] Starting subtest: basic-all [82.671242] Subtest basic-all: SUCCESS (2.271s) [82.844776] [044/162] (916s left) gem_sync (basic-each) [82.923466] Starting subtest: basic-each [85.218458] Subtest basic-each: SUCCESS (2.295s) [85.454698] [045/162] (913s left) gem_tiled_blits (basic) [85.591932] Starting subtest: basic [85.609203] Subtest basic: SUCCESS (0.017s) [85.728322] [046/162] (913s left) gem_tiled_fence_blits (basic) [86.313469] Starting subtest: basic [86.322830] Subtest basic: SUCCESS (0.011s) [86.419440] [047/162] (913s left) gem_tiled_pread_basic [86.758016] [048/162] (912s left) gem_wait (busy@all-engines) [86.841244] Starting subtest: busy [86.842536] Starting dynamic subtest: all-engines [87.382398] Dynamic subtest all-engines: SUCCESS (0.541s) [87.383584] Subtest busy: SUCCESS (0.542s) [87.614792] [049/162] (912s left) gem_wait (wait@all-engines) [87.694270] Starting subtest: wait [87.696149] Starting dynamic subtest: all-engines [88.781482] Dynamic subtest all-engines: SUCCESS (1.039s) [88.783749] Subtest wait: SUCCESS (1.040s) [88.953592] [050/162] (910s left) i915_getparams_basic (basic-eu-total) [89.015406] Starting subtest: basic-eu-total [89.017540] Subtest basic-eu-total: SUCCESS (0.000s) [89.070207] [051/162] (910s left) i915_getparams_basic (basic-subslice-total) [89.129127] Starting subtest: basic-subslice-total [89.131234] Subtest basic-subslice-total: SUCCESS (0.000s) [89.180825] [052/162] (910s left) i915_hangman (error-state-basic) [89.262932] Starting subtest: error-state-basic [89.272587] Subtest error-state-basic: SUCCESS (0.009s) [89.482924] [053/162] (910s left) i915_pciid [89.685811] [054/162] (910s left) intel_hwmon (hwmon-read) [89.741693] Subtest hwmon-read: SKIP (0.000s) [89.796102] [055/162] (910s left) intel_hwmon (hwmon-write) [89.849294] Subtest hwmon-write: SKIP (0.000s) [89.902440] [056/162] (910s left) kms_addfb_basic (addfb25-4-tiled) [90.182500] Starting subtest: addfb25-4-tiled [90.184136] Subtest addfb25-4-tiled: SUCCESS (0.001s) [90.275109] [057/162] (910s left) kms_addfb_basic (addfb25-bad-modifier) [90.549655] Starting subtest: addfb25-bad-modifier [90.551084] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [90.634869] [058/162] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [90.902614] Starting subtest: addfb25-framebuffer-vs-set-tiling [90.903789] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [90.996459] [059/162] (909s left) kms_addfb_basic (addfb25-modifier-no-flag) [91.270820] Starting subtest: addfb25-modifier-no-flag [91.271930] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [91.347849] [060/162] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [91.623307] Starting subtest: addfb25-x-tiled-legacy [91.624466] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [91.718414] [061/162] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [92.008478] Starting subtest: addfb25-x-tiled-mismatch-legacy [92.009316] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [92.090340] [062/162] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [92.358865] Starting subtest: addfb25-yf-tiled-legacy [92.360211] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [92.442894] [063/162] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [92.708556] Starting subtest: addfb25-y-tiled-legacy [92.709764] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [92.787245] [064/162] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [93.058361] Starting subtest: addfb25-y-tiled-small-legacy [93.059416] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [93.152032] [065/162] (907s left) kms_addfb_basic (bad-pitch-0) [93.207946] Starting subtest: bad-pitch-0 [93.208827] Subtest bad-pitch-0: SUCCESS (0.000s) [93.512751] [066/162] (907s left) kms_addfb_basic (bad-pitch-1024) [93.568941] Starting subtest: bad-pitch-1024 [93.569869] Subtest bad-pitch-1024: SUCCESS (0.000s) [93.876416] [067/162] (907s left) kms_addfb_basic (bad-pitch-128) [93.930909] Starting subtest: bad-pitch-128 [93.932046] Subtest bad-pitch-128: SUCCESS (0.000s) [94.239384] [068/162] (906s left) kms_addfb_basic (bad-pitch-256) [94.292999] Starting subtest: bad-pitch-256 [94.294116] Subtest bad-pitch-256: SUCCESS (0.000s) [94.585149] [069/162] (906s left) kms_addfb_basic (bad-pitch-32) [94.639330] Starting subtest: bad-pitch-32 [94.640281] Subtest bad-pitch-32: SUCCESS (0.000s) [94.946454] [070/162] (906s left) kms_addfb_basic (bad-pitch-63) [95.002652] Starting subtest: bad-pitch-63 [95.003763] Subtest bad-pitch-63: SUCCESS (0.000s) [95.291557] [071/162] (905s left) kms_addfb_basic (bad-pitch-65536) [95.346483] Starting subtest: bad-pitch-65536 [95.347442] Subtest bad-pitch-65536: SUCCESS (0.000s) [95.643383] [072/162] (905s left) kms_addfb_basic (bad-pitch-999) [95.698237] Starting subtest: bad-pitch-999 [95.699198] Subtest bad-pitch-999: SUCCESS (0.000s) [95.984141] [073/162] (905s left) kms_addfb_basic (basic) [96.039434] Starting subtest: basic [96.040363] Subtest basic: SUCCESS (0.000s) [96.335910] [074/162] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [96.392623] Starting subtest: basic-x-tiled-legacy [96.393531] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [96.669448] [075/162] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [96.724538] Starting subtest: basic-y-tiled-legacy [96.725501] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [97.025720] [076/162] (904s left) kms_addfb_basic (bo-too-small) [97.292870] Starting subtest: bo-too-small [97.294177] Subtest bo-too-small: SUCCESS (0.001s) [97.383241] [077/162] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling) [97.647881] Starting subtest: bo-too-small-due-to-tiling [97.649262] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [97.735223] [078/162] (903s left) kms_addfb_basic (clobberred-modifier) [97.790912] Starting subtest: clobberred-modifier [97.791845] Subtest clobberred-modifier: SUCCESS (0.000s) [98.099428] [079/162] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [98.154494] Starting subtest: framebuffer-vs-set-tiling [98.155421] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [98.453267] [080/162] (903s left) kms_addfb_basic (invalid-get-prop) [98.507208] Starting subtest: invalid-get-prop [98.508111] Subtest invalid-get-prop: SUCCESS (0.000s) [98.815107] [081/162] (903s left) kms_addfb_basic (invalid-get-prop-any) [98.872662] Starting subtest: invalid-get-prop-any [98.874112] Subtest invalid-get-prop-any: SUCCESS (0.000s) [99.181467] [082/162] (902s left) kms_addfb_basic (invalid-set-prop) [99.237113] Starting subtest: invalid-set-prop [99.237977] Subtest invalid-set-prop: SUCCESS (0.000s) [99.537754] [083/162] (902s left) kms_addfb_basic (invalid-set-prop-any) [99.594756] Starting subtest: invalid-set-prop-any [99.595677] Subtest invalid-set-prop-any: SUCCESS (0.000s) [99.906118] [084/162] (902s left) kms_addfb_basic (no-handle) [99.962235] Starting subtest: no-handle [99.963153] Subtest no-handle: SUCCESS (0.000s) [100.253291] [085/162] (901s left) kms_addfb_basic (size-max) [100.512415] Starting subtest: size-max [100.513753] Subtest size-max: SUCCESS (0.000s) [100.609699] [086/162] (901s left) kms_addfb_basic (small-bo) [100.879126] Starting subtest: small-bo [100.880282] Subtest small-bo: SUCCESS (0.000s) [100.954743] [087/162] (901s left) kms_addfb_basic (tile-pitch-mismatch) [101.010585] Starting subtest: tile-pitch-mismatch [101.011467] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [101.322625] [088/162] (901s left) kms_addfb_basic (too-high) [101.594317] Starting subtest: too-high [101.599445] Subtest too-high: SUCCESS (0.003s) [101.679265] [089/162] (900s left) kms_addfb_basic (too-wide) [101.941938] Starting subtest: too-wide [101.944126] Subtest too-wide: SUCCESS (0.000s) [102.046039] [090/162] (900s left) kms_addfb_basic (unused-handle) [102.100851] Starting subtest: unused-handle [102.101845] Subtest unused-handle: SUCCESS (0.000s) [102.399672] [091/162] (900s left) kms_addfb_basic (unused-modifier) [102.455092] Starting subtest: unused-modifier [102.455981] Subtest unused-modifier: SUCCESS (0.000s) [102.748382] [092/162] (899s left) kms_addfb_basic (unused-offsets) [102.803891] Starting subtest: unused-offsets [102.804823] Subtest unused-offsets: SUCCESS (0.000s) [103.099085] [093/162] (899s left) kms_addfb_basic (unused-pitches) [103.153473] Starting subtest: unused-pitches [103.154970] Subtest unused-pitches: SUCCESS (0.000s) [103.451755] [094/162] (899s left) kms_busy (basic) [103.726661] Subtest basic: SKIP (0.000s) [103.791783] [095/162] (899s left) kms_prop_blob (basic) [103.846737] Starting subtest: basic [103.847677] Subtest basic: SUCCESS (0.000s) [103.899657] [096/162] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [104.171896] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [104.234779] [097/162] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [104.509610] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [104.565722] [098/162] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [104.828524] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [104.897775] [099/162] (898s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [105.163663] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [105.247337] [100/162] (897s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [105.512242] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [105.574201] [101/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [105.847623] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [105.909966] [102/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [106.179357] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [106.243254] [103/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [106.514326] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [106.582551] [104/162] (896s left) kms_dsc (dsc-basic) [106.851024] Subtest dsc-basic: SKIP (0.000s) [106.917087] [105/162] (896s left) kms_flip (basic-flip-vs-dpms) [107.179581] Starting subtest: basic-flip-vs-dpms [107.182305] Subtest basic-flip-vs-dpms: SKIP (0.003s) [107.258445] [106/162] (896s left) kms_flip (basic-flip-vs-modeset) [107.531270] Starting subtest: basic-flip-vs-modeset [107.534486] Subtest basic-flip-vs-modeset: SKIP (0.003s) [107.620052] [107/162] (896s left) kms_flip (basic-flip-vs-wf_vblank) [107.887173] Starting subtest: basic-flip-vs-wf_vblank [107.890056] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [107.966962] [108/162] (895s left) kms_flip (basic-plain-flip) [108.231919] Starting subtest: basic-plain-flip [108.238779] Subtest basic-plain-flip: SKIP (0.005s) [108.316846] [109/162] (895s left) kms_force_connector_basic (force-connector-state) [108.675119] Starting subtest: force-connector-state [109.425651] Subtest force-connector-state: SUCCESS (0.750s) [110.012340] [110/162] (893s left) kms_force_connector_basic (force-edid) [110.380601] Starting subtest: force-edid [110.980137] Subtest force-edid: SUCCESS (0.599s) [111.460341] [111/162] (892s left) kms_force_connector_basic (force-load-detect) [111.819723] Starting subtest: force-load-detect [111.821986] Subtest force-load-detect: SKIP (0.000s) [112.193734] [112/162] (891s left) kms_force_connector_basic (prune-stale-modes) [112.557966] Starting subtest: prune-stale-modes [113.248941] Subtest prune-stale-modes: SUCCESS (0.693s) [113.732456] [113/162] (890s left) kms_frontbuffer_tracking (basic) [114.022809] Subtest basic: SKIP (0.000s) [114.122854] [114/162] (889s left) kms_hdmi_inject (inject-audio) [114.210906] Starting subtest: inject-audio [114.813105] Subtest inject-audio: SUCCESS (0.606s) [115.068536] [115/162] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [115.373357] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [115.563167] [116/162] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [115.893109] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [115.966247] [117/162] (888s left) kms_pipe_crc_basic (hang-read-crc) [116.231549] Subtest hang-read-crc: SKIP (0.000s) [116.296612] [118/162] (888s left) kms_pipe_crc_basic (nonblocking-crc) [116.563472] Subtest nonblocking-crc: SKIP (0.000s) [116.636618] [119/162] (887s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [116.897384] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [116.969560] [120/162] (887s left) kms_pipe_crc_basic (read-crc) [117.229243] Subtest read-crc: SKIP (0.000s) [117.302872] [121/162] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence) [117.562802] Subtest read-crc-frame-sequence: SKIP (0.000s) [117.640742] [122/162] (887s left) kms_pm_backlight (basic-brightness) [117.896792] Subtest basic-brightness: SKIP (0.000s) [117.962885] [123/162] (886s left) kms_pm_rpm (basic-pci-d3-state) [119.594716] Starting subtest: basic-pci-d3-state [119.926781] Subtest basic-pci-d3-state: SUCCESS (0.334s) [120.106389] [124/162] (884s left) kms_pm_rpm (basic-rte) [120.158682] Starting subtest: basic-rte [122.046869] Subtest basic-rte: SUCCESS (1.888s) [122.497224] [125/162] (882s left) kms_psr (psr-primary-page-flip) [122.882365] Subtest psr-primary-page-flip: SKIP (0.000s) [122.962561] [126/162] (882s left) kms_psr (psr-cursor-plane-move) [123.231627] Subtest psr-cursor-plane-move: SKIP (0.000s) [123.300193] [127/162] (881s left) kms_psr (psr-sprite-plane-onoff) [123.570152] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [123.643642] [128/162] (881s left) kms_psr (psr-primary-mmap-gtt) [123.916706] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [123.985215] [129/162] (881s left) kms_setmode (basic-clone-single-crtc) [124.041462] Starting subtest: basic-clone-single-crtc [124.043853] Subtest basic-clone-single-crtc: SKIP (0.000s) [124.108448] [130/162] (881s left) i915_pm_rps (basic-api) [124.175730] Starting subtest: basic-api [124.180340] Subtest basic-api: SUCCESS (0.005s) [124.257731] [131/162] (881s left) prime_self_import (basic-llseek-bad) [124.311250] Starting subtest: basic-llseek-bad [124.314338] Subtest basic-llseek-bad: SUCCESS (0.002s) [124.389595] [132/162] (881s left) prime_self_import (basic-llseek-size) [124.444123] Starting subtest: basic-llseek-size [124.448512] Subtest basic-llseek-size: SUCCESS (0.005s) [124.540446] [133/162] (881s left) prime_self_import (basic-with_fd_dup) [124.592289] Starting subtest: basic-with_fd_dup [124.597296] Subtest basic-with_fd_dup: SUCCESS (0.005s) [124.683506] [134/162] (880s left) prime_self_import (basic-with_one_bo) [124.737231] Starting subtest: basic-with_one_bo [124.740522] Subtest basic-with_one_bo: SUCCESS (0.004s) [124.804183] [135/162] (880s left) prime_self_import (basic-with_one_bo_two_files) [124.859309] Starting subtest: basic-with_one_bo_two_files [124.862310] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [124.940737] [136/162] (880s left) prime_self_import (basic-with_two_bos) [124.994126] Starting subtest: basic-with_two_bos [124.998186] Subtest basic-with_two_bos: SUCCESS (0.005s) [125.071283] [137/162] (880s left) prime_vgem (basic-fence-flip) [125.141477] Starting subtest: basic-fence-flip [125.354353] Subtest basic-fence-flip: SKIP (0.210s) [125.433682] [138/162] (880s left) prime_vgem (basic-fence-mmap) [125.501678] Starting subtest: basic-fence-mmap [125.534112] Subtest basic-fence-mmap: SUCCESS (0.032s) [125.620849] [139/162] (880s left) prime_vgem (basic-fence-read) [125.686381] Starting subtest: basic-fence-read [125.755475] Subtest basic-fence-read: SUCCESS (0.069s) [125.821720] [140/162] (880s left) prime_vgem (basic-gtt) [125.885739] Starting subtest: basic-gtt [125.900608] Subtest basic-gtt: SUCCESS (0.015s) [125.985373] [141/162] (880s left) prime_vgem (basic-read) [126.051126] Starting subtest: basic-read [126.083177] Subtest basic-read: SUCCESS (0.032s) [126.169369] [142/162] (879s left) prime_vgem (basic-write) [126.236289] Starting subtest: basic-write [126.269821] Subtest basic-write: SUCCESS (0.035s) [126.332647] [143/162] (879s left) vgem_basic (setversion) [126.390205] Starting subtest: setversion [126.392964] Subtest setversion: SUCCESS (0.000s) [126.450927] [144/162] (879s left) vgem_basic (create) [126.508313] Starting subtest: create [126.509225] Subtest create: SUCCESS (0.000s) [126.566111] [145/162] (879s left) vgem_basic (debugfs) [126.625980] Starting subtest: debugfs [126.627053] Subtest debugfs: SUCCESS (0.000s) [126.680652] [146/162] (879s left) vgem_basic (dmabuf-export) [126.741068] Starting subtest: dmabuf-export [126.745070] Subtest dmabuf-export: SUCCESS (0.003s) [126.825296] [147/162] (879s left) vgem_basic (dmabuf-fence) [126.883274] Starting subtest: dmabuf-fence [126.884225] Subtest dmabuf-fence: SUCCESS (0.001s) [126.940228] [148/162] (879s left) vgem_basic (dmabuf-fence-before) [126.998910] Starting subtest: dmabuf-fence-before [126.999986] Subtest dmabuf-fence-before: SUCCESS (0.000s) [127.056635] [149/162] (879s left) vgem_basic (dmabuf-mmap) [127.114380] Starting subtest: dmabuf-mmap [127.124122] Subtest dmabuf-mmap: SUCCESS (0.012s) [127.184270] [150/162] (879s left) vgem_basic (mmap) [127.241119] Starting subtest: mmap [127.251842] Subtest mmap: SUCCESS (0.011s) [127.309995] [151/162] (879s left) vgem_basic (second-client) [127.368139] Starting subtest: second-client [127.371191] Subtest second-client: SUCCESS (0.004s) [127.426835] [152/162] (879s left) vgem_basic (sysfs) [127.485527] Starting subtest: sysfs [127.486446] Subtest sysfs: SUCCESS (0.001s) [127.541280] [153/162] (879s left) core_hotunplug (unbind-rebind) [127.646083] Starting subtest: unbind-rebind [131.823321] Subtest unbind-rebind: SUCCESS (4.168s) [131.874496] [154/162] (874s left) vgem_basic (unload) [131.937082] Starting subtest: unload [161.001457] Subtest unload: SUCCESS (29.009s) [161.059883] [155/162] (845s left) i915_module_load (reload) [161.117277] Starting subtest: reload [164.492134] Subtest reload: SUCCESS (3.374s) [164.583119] [156/162] (842s left) gem_lmem_swapping (basic) [164.704375] Subtest basic: SKIP (0.000s) [164.761216] [157/162] (842s left) gem_lmem_swapping (parallel-random-engines) [164.822188] Subtest parallel-random-engines: SKIP (0.000s) [164.874650] [158/162] (842s left) gem_lmem_swapping (random-engines) [164.935668] Subtest random-engines: SKIP (0.000s) [164.989693] [159/162] (842s left) gem_lmem_swapping (verify-random) [165.051639] Subtest verify-random: SKIP (0.000s) [165.103144] [160/162] (842s left) i915_pm_rpm (module-reload) [168.296192] Starting subtest: module-reload [183.003741] Subtest module-reload: SUCCESS (14.655s) [183.072528] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [183.073979] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [183.076686] [161/162] (824s left) i915_selftest (live) [183.143493] Starting subtest: live [183.144803] Starting dynamic subtest: sanitycheck [185.704150] Dynamic subtest sanitycheck: SUCCESS (2.504s) [185.714426] Starting dynamic subtest: uncore [188.205018] Dynamic subtest uncore: SUCCESS (2.500s) [188.215338] Starting dynamic subtest: workarounds [191.062013] Dynamic subtest workarounds: SUCCESS (2.856s) [191.072222] Starting dynamic subtest: gt_engines [194.115314] Dynamic subtest gt_engines: SUCCESS (3.052s) [194.125600] Starting dynamic subtest: gt_timelines [208.746500] Dynamic subtest gt_timelines: SUCCESS (14.630s) [208.760208] Starting dynamic subtest: gt_contexts [211.442347] Dynamic subtest gt_contexts: SUCCESS (2.695s) [211.452976] Starting dynamic subtest: gt_lrc [217.168011] Dynamic subtest gt_lrc: SUCCESS (5.724s) [217.178322] Starting dynamic subtest: gt_mocs [219.851438] Dynamic subtest gt_mocs: SUCCESS (2.683s) [219.863654] Starting dynamic subtest: gt_pm [231.047614] Dynamic subtest gt_pm: SUCCESS (11.194s) [231.057897] Starting dynamic subtest: gt_heartbeat [233.551314] Dynamic subtest gt_heartbeat: SUCCESS (2.503s) [233.561666] Starting dynamic subtest: gt_tlb [237.721176] Dynamic subtest gt_tlb: SUCCESS (4.169s) [237.731527] Starting dynamic subtest: requests [247.781857] Dynamic subtest requests: SUCCESS (10.058s) [247.792206] Starting dynamic subtest: migrate [253.397596] Dynamic subtest migrate: SUCCESS (5.614s) [253.407931] Starting dynamic subtest: active [255.957267] Dynamic subtest active: SUCCESS (2.559s) [255.967630] Starting dynamic subtest: objects [259.362304] Dynamic subtest objects: SUCCESS (3.403s) [259.372626] Starting dynamic subtest: mman [265.468708] Dynamic subtest mman: SUCCESS (6.104s) [265.479076] Starting dynamic subtest: dmabuf [267.991235] Dynamic subtest dmabuf: SUCCESS (2.521s) [268.001579] Starting dynamic subtest: vma [270.555487] Dynamic subtest vma: SUCCESS (2.562s) [270.565942] Starting dynamic subtest: coherency [274.336093] Dynamic subtest coherency: SUCCESS (3.779s) [274.349642] Starting dynamic subtest: gtt [284.193314] Dynamic subtest gtt: SUCCESS (9.855s) [284.203813] Starting dynamic subtest: gem [287.323398] Dynamic subtest gem: SUCCESS (3.128s) [287.337080] Starting dynamic subtest: evict [292.098651] Dynamic subtest evict: SUCCESS (4.773s) [292.112242] Starting dynamic subtest: hugepages [301.207368] Dynamic subtest hugepages: SUCCESS (9.106s) [301.217904] Starting dynamic subtest: gem_contexts [320.771851] Dynamic subtest gem_contexts: SUCCESS (19.562s) [320.784672] Starting dynamic subtest: client [323.401419] Dynamic subtest client: SUCCESS (2.628s) [323.411881] Starting dynamic subtest: gem_migrate [325.910644] Dynamic subtest gem_migrate: SUCCESS (2.507s) [325.921446] Starting dynamic subtest: reset [328.851200] Dynamic subtest reset: SUCCESS (2.938s) [328.861582] Starting dynamic subtest: memory_region [331.368367] Dynamic subtest memory_region: SUCCESS (2.515s) [331.381989] Starting dynamic subtest: hangcheck [362.587325] Dynamic subtest hangcheck: SUCCESS (31.217s) [362.597759] Starting dynamic subtest: execlists [378.134820] Dynamic subtest execlists: SUCCESS (15.545s) [378.145246] Starting dynamic subtest: ring_submission [380.654250] Dynamic subtest ring_submission: SUCCESS (2.517s) [380.664796] Starting dynamic subtest: perf [383.248128] Dynamic subtest perf: SUCCESS (2.591s) [383.258531] Starting dynamic subtest: slpc [385.742354] Dynamic subtest slpc: SUCCESS (2.492s) [385.756048] Starting dynamic subtest: guc [388.279417] Dynamic subtest guc: SUCCESS (2.534s) [388.289995] Starting dynamic subtest: guc_multi_lrc [390.790498] Dynamic subtest guc_multi_lrc: SUCCESS (2.508s) [390.804139] Starting dynamic subtest: guc_hang [393.338508] Dynamic subtest guc_hang: SUCCESS (2.545s) [393.348982] Starting dynamic subtest: late_gt_pm [395.857187] Dynamic subtest late_gt_pm: SUCCESS (2.516s) [395.859606] Subtest live: SUCCESS (212.654s) [395.932876] [162/162] (611s left) dmabuf (all-tests) [396.000990] Starting subtest: all-tests [396.002605] Starting dynamic subtest: sanitycheck [396.078467] Dynamic subtest sanitycheck: SUCCESS (0.076s) [396.110714] Starting dynamic subtest: dma_fence [396.304900] Dynamic subtest dma_fence: SUCCESS (0.221s) [396.333467] Starting dynamic subtest: dma_fence_chain [396.336576] Dynamic subtest dma_fence_chain: SKIP (0.000s) [396.366712] Starting dynamic subtest: dma_fence_unwrap [396.396427] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s) [396.430938] Starting dynamic subtest: dma_resv [396.484508] Dynamic subtest dma_resv: SUCCESS (0.082s) [396.491821] Subtest all-tests: SUCCESS (0.487s) [396.575600] 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.