[34.276228] Initializing watchdogs [34.276332] /dev/watchdog0 [34.302786] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [34.309575] [001/162] (960s left) i915_module_load (load) [34.382514] Starting subtest: load [36.849064] Subtest load: SUCCESS (2.465s) [36.896241] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [36.898402] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [36.902283] [002/162] (957s left) core_auth (basic-auth) [37.023602] Starting subtest: basic-auth [37.024745] Subtest basic-auth: SUCCESS (0.002s) [37.101552] [003/162] (957s left) core_debugfs (read-all-entries) [37.160635] Starting subtest: read-all-entries [37.162994] Subtest read-all-entries: SUCCESS (0.003s) [37.211832] [004/162] (957s left) core_sysfs (read-all-entries) [37.272037] Starting subtest: read-all-entries [37.278381] Subtest read-all-entries: SUCCESS (0.006s) [37.333764] [005/162] (957s left) fbdev (eof) [37.402529] Subtest eof: SKIP (0.000s) [37.449600] [006/162] (957s left) fbdev (info) [37.519291] Subtest info: SKIP (0.000s) [37.566335] [007/162] (957s left) fbdev (nullptr) [37.635859] Subtest nullptr: SKIP (0.000s) [37.683681] [008/162] (957s left) fbdev (read) [37.753278] Subtest read: SKIP (0.000s) [37.800443] [009/162] (957s left) fbdev (write) [37.868891] Subtest write: SKIP (0.000s) [37.916475] [010/162] (957s left) gem_basic (bad-close) [37.975400] Starting subtest: bad-close [37.977298] Subtest bad-close: SUCCESS (0.000s) [38.026252] [011/162] (957s left) gem_basic (create-close) [38.084473] Starting subtest: create-close [38.086510] Subtest create-close: SUCCESS (0.000s) [38.152675] [012/162] (957s left) gem_basic (create-fd-close) [38.210773] Starting subtest: create-fd-close [38.212730] Subtest create-fd-close: SUCCESS (0.000s) [38.287555] [013/162] (957s left) gem_busy (busy@all-engines) [38.367728] Starting subtest: busy [38.368815] Starting dynamic subtest: all-engines [38.425344] Dynamic subtest all-engines: SUCCESS (0.057s) [38.426642] Subtest busy: SUCCESS (0.058s) [38.819663] [014/162] (956s left) gem_close_race (basic-process) [38.905608] Starting subtest: basic-process [38.974395] Subtest basic-process: SUCCESS (0.070s) [39.218115] [015/162] (956s left) gem_close_race (basic-threads) [39.299634] Starting subtest: basic-threads [40.506079] Subtest basic-threads: SUCCESS (1.207s) [40.745471] [016/162] (954s left) gem_ctx_create (basic) [40.826859] Starting subtest: basic [40.828043] Subtest basic: SUCCESS (0.001s) [41.014921] [017/162] (954s left) gem_ctx_create (basic-files) [41.090199] Starting subtest: basic-files [43.107170] Subtest basic-files: SUCCESS (2.017s) [43.349487] [018/162] (952s left) gem_ctx_exec (basic) [43.415674] Starting subtest: basic [43.423773] Subtest basic: SUCCESS (0.008s) [43.497449] [019/162] (952s left) gem_exec_basic (basic) [43.567668] Starting subtest: basic [43.568848] Starting dynamic subtest: rcs0-smem [43.571305] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [43.583423] Starting dynamic subtest: bcs0-smem [43.584708] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [43.595489] Starting dynamic subtest: vcs0-smem [43.596829] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [43.607455] Starting dynamic subtest: vcs1-smem [43.608796] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [43.619491] Starting dynamic subtest: vecs0-smem [43.620744] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [43.621920] Subtest basic: SUCCESS (0.011s) [43.772775] [020/162] (952s left) gem_exec_create (basic) [44.014192] Starting subtest: basic [44.015398] Starting dynamic subtest: smem [46.096190] Dynamic subtest smem: SUCCESS (2.042s) [46.098153] Subtest basic: SUCCESS (2.043s) [46.254252] [021/162] (949s left) gem_exec_fence (basic-busy) [46.486189] Starting subtest: basic-busy [46.487453] Starting dynamic subtest: rcs0 [46.520017] Dynamic subtest rcs0: SUCCESS (0.032s) [46.530758] Starting dynamic subtest: bcs0 [46.541407] Dynamic subtest bcs0: SUCCESS (0.023s) [46.552318] Starting dynamic subtest: vcs0 [46.564996] Dynamic subtest vcs0: SUCCESS (0.023s) [46.576944] Starting dynamic subtest: vcs1 [46.585338] Dynamic subtest vcs1: SUCCESS (0.020s) [46.597676] Starting dynamic subtest: vecs0 [46.605297] Dynamic subtest vecs0: SUCCESS (0.020s) [46.606510] Subtest basic-busy: SUCCESS (0.120s) [47.291543] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [47.294223] [022/162] (948s left) gem_exec_fence (basic-wait) [47.517959] Starting subtest: basic-wait [47.519288] Starting dynamic subtest: rcs0 [47.547416] Dynamic subtest rcs0: SUCCESS (0.031s) [47.558993] Starting dynamic subtest: bcs0 [47.573384] Dynamic subtest bcs0: SUCCESS (0.025s) [47.584487] Starting dynamic subtest: vcs0 [47.602506] Dynamic subtest vcs0: SUCCESS (0.030s) [47.614802] Starting dynamic subtest: vcs1 [47.627462] Dynamic subtest vcs1: SUCCESS (0.025s) [47.638747] Starting dynamic subtest: vecs0 [47.661691] Dynamic subtest vecs0: SUCCESS (0.034s) [47.663075] Subtest basic-wait: SUCCESS (0.145s) [48.323185] [023/162] (947s left) gem_exec_fence (basic-await) [48.551428] Starting subtest: basic-await [48.552819] Starting dynamic subtest: rcs0 [48.664289] Dynamic subtest rcs0: SUCCESS (0.106s) [48.676544] Starting dynamic subtest: bcs0 [48.761387] Dynamic subtest bcs0: SUCCESS (0.103s) [48.775807] Starting dynamic subtest: vcs0 [48.873967] Dynamic subtest vcs0: SUCCESS (0.112s) [48.886630] Starting dynamic subtest: vcs1 [48.981451] Dynamic subtest vcs1: SUCCESS (0.106s) [48.996080] Starting dynamic subtest: vecs0 [49.095617] Dynamic subtest vecs0: SUCCESS (0.114s) [49.096972] Subtest basic-await: SUCCESS (0.545s) [49.763928] [024/162] (946s left) gem_exec_fence (nb-await) [49.992699] Starting subtest: nb-await [49.993943] Starting dynamic subtest: rcs0 [50.058760] Dynamic subtest rcs0: SUCCESS (0.068s) [50.077810] Starting dynamic subtest: bcs0 [50.131978] Dynamic subtest bcs0: SUCCESS (0.071s) [50.168263] Starting dynamic subtest: vcs0 [50.221645] Dynamic subtest vcs0: SUCCESS (0.089s) [50.251389] Starting dynamic subtest: vcs1 [50.303991] Dynamic subtest vcs1: SUCCESS (0.079s) [50.335071] Starting dynamic subtest: vecs0 [50.386222] Dynamic subtest vecs0: SUCCESS (0.081s) [50.388590] Subtest nb-await: SUCCESS (0.395s) [51.051136] [025/162] (945s left) gem_exec_gttfill (basic) [51.132747] Starting subtest: basic [56.098659] Subtest basic: SUCCESS (4.965s) [56.360295] [026/162] (940s left) gem_exec_parallel (engines) [56.603687] Starting subtest: engines [56.604666] Starting dynamic subtest: basic [58.819213] Dynamic subtest basic: SUCCESS (2.232s) [58.834627] Starting dynamic subtest: contexts [61.503427] Dynamic subtest contexts: SUCCESS (2.731s) [61.518334] Starting dynamic subtest: fds [67.143370] Dynamic subtest fds: SUCCESS (5.637s) [67.157359] Starting dynamic subtest: userptr [69.968781] Dynamic subtest userptr: SUCCESS (2.786s) [69.970853] Subtest engines: SUCCESS (13.387s) [70.148247] [027/162] (926s left) gem_exec_store (basic) [70.235549] Starting subtest: basic [70.288650] Subtest basic: SUCCESS (0.054s) [70.480771] [028/162] (926s left) gem_flink_basic (bad-flink) [70.541410] Starting subtest: bad-flink [70.542567] Subtest bad-flink: SUCCESS (0.000s) [70.597759] [029/162] (926s left) gem_flink_basic (bad-open) [70.657529] Starting subtest: bad-open [70.658691] Subtest bad-open: SUCCESS (0.000s) [70.758340] [030/162] (925s left) gem_flink_basic (basic) [70.976307] Starting subtest: basic [70.978577] Subtest basic: SUCCESS (0.001s) [71.067433] [031/162] (925s left) gem_flink_basic (double-flink) [71.125063] Starting subtest: double-flink [71.126096] Subtest double-flink: SUCCESS (0.000s) [71.202967] [032/162] (925s left) gem_flink_basic (flink-lifetime) [71.261221] Starting subtest: flink-lifetime [71.263186] Subtest flink-lifetime: SUCCESS (0.002s) [71.336461] [033/162] (925s left) gem_huc_copy (huc-copy) [71.407854] Starting subtest: huc-copy [71.410938] Subtest huc-copy: SKIP (0.000s) [71.493972] [034/162] (925s left) gem_linear_blits (basic) [71.672971] Starting subtest: basic [71.681877] Subtest basic: SUCCESS (0.009s) [71.790587] [035/162] (925s left) gem_mmap (basic) [72.023197] Starting subtest: basic [72.030582] Subtest basic: SUCCESS (0.001s) [72.115610] [036/162] (924s left) gem_mmap_gtt (basic) [72.175356] Starting subtest: basic [72.176377] Subtest basic: SUCCESS (0.001s) [72.234937] [037/162] (924s left) gem_render_linear_blits (basic) [72.303068] Starting subtest: basic [72.337213] Subtest basic: SUCCESS (0.034s) [72.414449] [038/162] (924s left) gem_render_tiled_blits (basic) [72.485380] Starting subtest: basic [72.529120] Subtest basic: SUCCESS (0.043s) [72.598567] [039/162] (924s left) gem_ringfill (basic-all) [72.890257] Starting subtest: basic-all [74.119160] Subtest basic-all: SUCCESS (1.172s) [74.174852] [040/162] (923s left) gem_softpin (allocator-basic) [74.251069] Starting subtest: allocator-basic [74.463282] Subtest allocator-basic: SUCCESS (0.155s) [74.517800] [041/162] (922s left) gem_softpin (allocator-basic-reserve) [74.595468] Starting subtest: allocator-basic-reserve [74.796476] Subtest allocator-basic-reserve: SUCCESS (0.146s) [74.850096] [042/162] (922s left) gem_softpin (safe-alignment) [74.923463] Starting subtest: safe-alignment [74.943208] Subtest safe-alignment: SUCCESS (0.019s) [75.039694] [043/162] (922s left) gem_sync (basic-all) [75.119764] Starting subtest: basic-all [77.687328] Subtest basic-all: SUCCESS (2.529s) [77.867267] [044/162] (919s left) gem_sync (basic-each) [77.947050] Starting subtest: basic-each [80.170520] Subtest basic-each: SUCCESS (2.223s) [80.411832] [045/162] (917s left) gem_tiled_blits (basic) [80.562826] Starting subtest: basic [80.581370] Subtest basic: SUCCESS (0.020s) [80.715073] [046/162] (917s left) gem_tiled_fence_blits (basic) [81.289791] Starting subtest: basic [81.301260] Subtest basic: SUCCESS (0.012s) [81.447444] [047/162] (916s left) gem_tiled_pread_basic (basic) [81.642165] Starting subtest: basic [81.851623] Subtest basic: SUCCESS (0.154s) [81.917154] [048/162] (916s left) gem_wait (busy@all-engines) [82.008621] Starting subtest: busy [82.009873] Starting dynamic subtest: all-engines [82.585755] Dynamic subtest all-engines: SUCCESS (0.527s) [82.587933] Subtest busy: SUCCESS (0.527s) [82.715538] [049/162] (915s left) gem_wait (wait@all-engines) [82.802980] Starting subtest: wait [82.804214] Starting dynamic subtest: all-engines [83.890111] Dynamic subtest all-engines: SUCCESS (1.036s) [83.892654] Subtest wait: SUCCESS (1.038s) [84.060028] [050/162] (913s left) i915_getparams_basic (basic-eu-total) [84.122459] Starting subtest: basic-eu-total [84.124785] Subtest basic-eu-total: SUCCESS (0.000s) [84.180708] [051/162] (913s left) i915_getparams_basic (basic-subslice-total) [84.241130] Starting subtest: basic-subslice-total [84.244331] Subtest basic-subslice-total: SUCCESS (0.000s) [84.299154] [052/162] (913s left) i915_hangman (error-state-basic) [84.382430] Starting subtest: error-state-basic [84.391933] Subtest error-state-basic: SUCCESS (0.009s) [84.628449] [053/162] (913s left) i915_pciid [84.792981] [054/162] (913s left) intel_hwmon (hwmon-read) [84.853326] Subtest hwmon-read: SKIP (0.000s) [84.908913] [055/162] (913s left) intel_hwmon (hwmon-write) [84.967628] Subtest hwmon-write: SKIP (0.000s) [85.023861] [056/162] (913s left) kms_addfb_basic (addfb25-4-tiled) [85.300511] Starting subtest: addfb25-4-tiled [85.301888] Subtest addfb25-4-tiled: SUCCESS (0.001s) [85.385838] [057/162] (913s left) kms_addfb_basic (addfb25-bad-modifier) [85.659507] Starting subtest: addfb25-bad-modifier [85.660666] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [85.740768] [058/162] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [86.021314] Starting subtest: addfb25-framebuffer-vs-set-tiling [86.023070] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [86.115646] [059/162] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [86.392450] Starting subtest: addfb25-modifier-no-flag [86.393559] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [86.478055] [060/162] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [86.751419] Starting subtest: addfb25-x-tiled-legacy [86.752542] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [86.843432] [061/162] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.117681] Starting subtest: addfb25-x-tiled-mismatch-legacy [87.118956] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [87.202375] [062/162] (911s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [87.477977] Starting subtest: addfb25-yf-tiled-legacy [87.479332] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [87.558627] [063/162] (911s left) kms_addfb_basic (addfb25-y-tiled-legacy) [87.835818] Starting subtest: addfb25-y-tiled-legacy [87.837238] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [87.920817] [064/162] (911s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [88.198428] Starting subtest: addfb25-y-tiled-small-legacy [88.199563] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [88.268422] [065/162] (910s left) kms_addfb_basic (bad-pitch-0) [88.327469] Starting subtest: bad-pitch-0 [88.328443] Subtest bad-pitch-0: SUCCESS (0.000s) [88.624155] [066/162] (910s left) kms_addfb_basic (bad-pitch-1024) [88.729785] Starting subtest: bad-pitch-1024 [88.731133] Subtest bad-pitch-1024: SUCCESS (0.000s) [89.029372] [067/162] (910s left) kms_addfb_basic (bad-pitch-128) [89.089737] Starting subtest: bad-pitch-128 [89.090856] Subtest bad-pitch-128: SUCCESS (0.000s) [89.389462] [068/162] (909s left) kms_addfb_basic (bad-pitch-256) [89.449412] Starting subtest: bad-pitch-256 [89.450410] Subtest bad-pitch-256: SUCCESS (0.000s) [89.751442] [069/162] (909s left) kms_addfb_basic (bad-pitch-32) [89.811329] Starting subtest: bad-pitch-32 [89.812839] Subtest bad-pitch-32: SUCCESS (0.000s) [90.112826] [070/162] (909s left) kms_addfb_basic (bad-pitch-63) [90.173121] Starting subtest: bad-pitch-63 [90.174111] Subtest bad-pitch-63: SUCCESS (0.000s) [90.475428] [071/162] (909s left) kms_addfb_basic (bad-pitch-65536) [90.535576] Starting subtest: bad-pitch-65536 [90.536619] Subtest bad-pitch-65536: SUCCESS (0.000s) [90.838688] [072/162] (908s left) kms_addfb_basic (bad-pitch-999) [90.898197] Starting subtest: bad-pitch-999 [90.899143] Subtest bad-pitch-999: SUCCESS (0.000s) [91.202768] [073/162] (908s left) kms_addfb_basic (basic) [91.263263] Starting subtest: basic [91.264246] Subtest basic: SUCCESS (0.000s) [91.560793] [074/162] (908s left) kms_addfb_basic (basic-x-tiled-legacy) [91.624529] Starting subtest: basic-x-tiled-legacy [91.625492] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [91.912978] [075/162] (907s left) kms_addfb_basic (basic-y-tiled-legacy) [91.973245] Starting subtest: basic-y-tiled-legacy [91.974271] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [92.268618] [076/162] (907s left) kms_addfb_basic (bo-too-small) [92.546798] Starting subtest: bo-too-small [92.548501] Subtest bo-too-small: SUCCESS (0.000s) [92.632656] [077/162] (907s left) kms_addfb_basic (bo-too-small-due-to-tiling) [92.908794] Starting subtest: bo-too-small-due-to-tiling [92.909983] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [93.008343] [078/162] (906s left) kms_addfb_basic (clobberred-modifier) [93.067830] Starting subtest: clobberred-modifier [93.068961] Subtest clobberred-modifier: SUCCESS (0.000s) [93.358385] [079/162] (906s left) kms_addfb_basic (framebuffer-vs-set-tiling) [93.418608] Starting subtest: framebuffer-vs-set-tiling [93.420593] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.721589] [080/162] (906s left) kms_addfb_basic (invalid-get-prop) [93.781228] Starting subtest: invalid-get-prop [93.782194] Subtest invalid-get-prop: SUCCESS (0.000s) [94.082750] [081/162] (906s left) kms_addfb_basic (invalid-get-prop-any) [94.142477] Starting subtest: invalid-get-prop-any [94.143467] Subtest invalid-get-prop-any: SUCCESS (0.000s) [94.449417] [082/162] (905s left) kms_addfb_basic (invalid-set-prop) [94.509450] Starting subtest: invalid-set-prop [94.510412] Subtest invalid-set-prop: SUCCESS (0.000s) [94.818841] [083/162] (905s left) kms_addfb_basic (invalid-set-prop-any) [94.878270] Starting subtest: invalid-set-prop-any [94.879290] Subtest invalid-set-prop-any: SUCCESS (0.000s) [95.190513] [084/162] (905s left) kms_addfb_basic (no-handle) [95.251186] Starting subtest: no-handle [95.252083] Subtest no-handle: SUCCESS (0.000s) [95.553305] [085/162] (904s left) kms_addfb_basic (size-max) [95.824586] Starting subtest: size-max [95.825690] Subtest size-max: SUCCESS (0.000s) [95.903783] [086/162] (904s left) kms_addfb_basic (small-bo) [96.180821] Starting subtest: small-bo [96.182076] Subtest small-bo: SUCCESS (0.000s) [96.270905] [087/162] (904s left) kms_addfb_basic (tile-pitch-mismatch) [96.331538] Starting subtest: tile-pitch-mismatch [96.332574] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [96.750883] [088/162] (903s left) kms_addfb_basic (too-high) [97.052767] Starting subtest: too-high [97.054099] Subtest too-high: SUCCESS (0.001s) [97.141013] [089/162] (903s left) kms_addfb_basic (too-wide) [97.405863] Starting subtest: too-wide [97.407765] Subtest too-wide: SUCCESS (0.000s) [97.490267] [090/162] (903s left) kms_addfb_basic (unused-handle) [97.640456] Starting subtest: unused-handle [97.642998] Subtest unused-handle: SUCCESS (0.000s) [97.996548] [091/162] (902s left) kms_addfb_basic (unused-modifier) [98.056446] Starting subtest: unused-modifier [98.057420] Subtest unused-modifier: SUCCESS (0.000s) [98.394919] [092/162] (902s left) kms_addfb_basic (unused-offsets) [98.456759] Starting subtest: unused-offsets [98.457952] Subtest unused-offsets: SUCCESS (0.000s) [98.791468] [093/162] (902s left) kms_addfb_basic (unused-pitches) [98.850710] Starting subtest: unused-pitches [98.851674] Subtest unused-pitches: SUCCESS (0.000s) [99.193200] [094/162] (901s left) kms_busy (basic) [99.507451] Subtest basic: SKIP (0.000s) [99.566325] [095/162] (901s left) kms_prop_blob (basic) [99.627443] Starting subtest: basic [99.628386] Subtest basic: SUCCESS (0.000s) [99.684140] [096/162] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [99.987885] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [100.055510] [097/162] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [100.359914] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [100.416574] [098/162] (900s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [100.721034] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [100.780780] [099/162] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [101.103558] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [101.159396] [100/162] (900s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [101.457169] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [101.527990] [101/162] (900s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [101.827296] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [101.887475] [102/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [102.193555] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [102.251948] [103/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [102.563969] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [102.620150] [104/162] (899s left) kms_dsc (dsc-basic) [102.920634] Subtest dsc-basic: SKIP (0.000s) [103.007667] [105/162] (898s left) kms_flip (basic-flip-vs-dpms) [103.296049] Starting subtest: basic-flip-vs-dpms [103.302089] Subtest basic-flip-vs-dpms: SKIP (0.005s) [103.382458] [106/162] (898s left) kms_flip (basic-flip-vs-modeset) [103.695949] Starting subtest: basic-flip-vs-modeset [103.699494] Subtest basic-flip-vs-modeset: SKIP (0.003s) [103.771630] [107/162] (898s left) kms_flip (basic-flip-vs-wf_vblank) [104.056864] Starting subtest: basic-flip-vs-wf_vblank [104.062124] Subtest basic-flip-vs-wf_vblank: SKIP (0.004s) [104.137672] [108/162] (897s left) kms_flip (basic-plain-flip) [104.434040] Starting subtest: basic-plain-flip [104.439440] Subtest basic-plain-flip: SKIP (0.005s) [104.516416] [109/162] (897s left) kms_force_connector_basic (force-connector-state) [104.929417] Starting subtest: force-connector-state [105.777875] Subtest force-connector-state: SUCCESS (0.847s) [106.489131] [110/162] (895s left) kms_force_connector_basic (force-edid) [106.902386] Starting subtest: force-edid [107.586364] Subtest force-edid: SUCCESS (0.685s) [108.129339] [111/162] (894s left) kms_force_connector_basic (force-load-detect) [108.535321] Starting subtest: force-load-detect [108.538233] Subtest force-load-detect: SKIP (0.000s) [108.943428] [112/162] (893s left) kms_force_connector_basic (prune-stale-modes) [109.357689] Starting subtest: prune-stale-modes [110.144435] Subtest prune-stale-modes: SUCCESS (0.787s) [110.675951] [113/162] (891s left) kms_frontbuffer_tracking (basic) [111.045536] Subtest basic: SKIP (0.000s) [111.122769] [114/162] (891s left) kms_hdmi_inject (inject-audio) [111.187210] Starting subtest: inject-audio [111.877282] Subtest inject-audio: SUCCESS (0.688s) [112.153611] [115/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [112.447883] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [112.521563] [116/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [112.849590] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [112.924178] [117/162] (889s left) kms_pipe_crc_basic (hang-read-crc) [113.238704] Subtest hang-read-crc: SKIP (0.000s) [113.303889] [118/162] (889s left) kms_pipe_crc_basic (nonblocking-crc) [113.594648] Subtest nonblocking-crc: SKIP (0.000s) [113.667583] [119/162] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [113.962330] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [114.036714] [120/162] (888s left) kms_pipe_crc_basic (read-crc) [114.355642] Subtest read-crc: SKIP (0.000s) [114.419037] [121/162] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [114.712115] Subtest read-crc-frame-sequence: SKIP (0.000s) [114.786823] [122/162] (888s left) kms_pm_backlight (basic-brightness) [115.126761] Subtest basic-brightness: SKIP (0.000s) [115.192036] [123/162] (887s left) kms_pm_rpm (basic-pci-d3-state) [116.904417] Starting subtest: basic-pci-d3-state [117.225173] Subtest basic-pci-d3-state: SUCCESS (0.322s) [117.421866] [124/162] (885s left) kms_pm_rpm (basic-rte) [117.661403] Starting subtest: basic-rte [119.640425] Subtest basic-rte: SUCCESS (1.980s) [120.165954] [125/162] (882s left) kms_psr (psr-primary-page-flip) [120.590360] Subtest psr-primary-page-flip: SKIP (0.000s) [120.671600] [126/162] (882s left) kms_psr (psr-cursor-plane-move) [120.968910] Subtest psr-cursor-plane-move: SKIP (0.000s) [121.045660] [127/162] (882s left) kms_psr (psr-sprite-plane-onoff) [121.337739] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [121.411908] [128/162] (881s left) kms_psr (psr-primary-mmap-gtt) [121.713094] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [121.793932] [129/162] (881s left) kms_setmode (basic-clone-single-crtc) [121.855243] Starting subtest: basic-clone-single-crtc [121.858390] Subtest basic-clone-single-crtc: SKIP (0.000s) [121.919500] [130/162] (881s left) i915_pm_rps (basic-api) [121.993022] Starting subtest: basic-api [121.998809] Subtest basic-api: SUCCESS (0.005s) [122.079511] [131/162] (881s left) prime_self_import (basic-llseek-bad) [122.136909] Starting subtest: basic-llseek-bad [122.139200] Subtest basic-llseek-bad: SUCCESS (0.003s) [122.237060] [132/162] (881s left) prime_self_import (basic-llseek-size) [122.292966] Starting subtest: basic-llseek-size [122.297153] Subtest basic-llseek-size: SUCCESS (0.004s) [122.380219] [133/162] (881s left) prime_self_import (basic-with_fd_dup) [122.437128] Starting subtest: basic-with_fd_dup [122.443135] Subtest basic-with_fd_dup: SUCCESS (0.005s) [122.527890] [134/162] (881s left) prime_self_import (basic-with_one_bo) [122.584409] Starting subtest: basic-with_one_bo [122.589895] Subtest basic-with_one_bo: SUCCESS (0.005s) [122.661431] [135/162] (881s left) prime_self_import (basic-with_one_bo_two_files) [122.717393] Starting subtest: basic-with_one_bo_two_files [122.722302] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [122.804871] [136/162] (880s left) prime_self_import (basic-with_two_bos) [122.863782] Starting subtest: basic-with_two_bos [122.866979] Subtest basic-with_two_bos: SUCCESS (0.005s) [122.956225] [137/162] (880s left) prime_vgem (basic-fence-flip) [123.027583] Starting subtest: basic-fence-flip [123.267125] Subtest basic-fence-flip: SKIP (0.236s) [123.342940] [138/162] (880s left) prime_vgem (basic-fence-mmap) [123.412355] Starting subtest: basic-fence-mmap [123.449183] Subtest basic-fence-mmap: SUCCESS (0.036s) [123.519777] [139/162] (880s left) prime_vgem (basic-fence-read) [123.591293] Starting subtest: basic-fence-read [123.668164] Subtest basic-fence-read: SUCCESS (0.077s) [123.735751] [140/162] (880s left) prime_vgem (basic-gtt) [123.810590] Starting subtest: basic-gtt [123.829526] Subtest basic-gtt: SUCCESS (0.019s) [123.924648] [141/162] (880s left) prime_vgem (basic-read) [124.014211] Starting subtest: basic-read [124.051176] Subtest basic-read: SUCCESS (0.040s) [124.141387] [142/162] (880s left) prime_vgem (basic-write) [124.231635] Starting subtest: basic-write [124.266951] Subtest basic-write: SUCCESS (0.035s) [124.333314] [143/162] (879s left) vgem_basic (setversion) [124.396878] Starting subtest: setversion [124.398872] Subtest setversion: SUCCESS (0.000s) [124.458258] [144/162] (879s left) vgem_basic (create) [124.519507] Starting subtest: create [124.520480] Subtest create: SUCCESS (0.000s) [124.585475] [145/162] (879s left) vgem_basic (debugfs) [124.646362] Starting subtest: debugfs [124.647350] Subtest debugfs: SUCCESS (0.001s) [124.708602] [146/162] (879s left) vgem_basic (dmabuf-export) [124.771452] Starting subtest: dmabuf-export [124.773469] Subtest dmabuf-export: SUCCESS (0.003s) [124.866745] [147/162] (879s left) vgem_basic (dmabuf-fence) [124.929386] Starting subtest: dmabuf-fence [124.930356] Subtest dmabuf-fence: SUCCESS (0.001s) [124.992863] [148/162] (879s left) vgem_basic (dmabuf-fence-before) [125.052271] Starting subtest: dmabuf-fence-before [125.053294] Subtest dmabuf-fence-before: SUCCESS (0.001s) [125.112281] [149/162] (879s left) vgem_basic (dmabuf-mmap) [125.174287] Starting subtest: dmabuf-mmap [125.185883] Subtest dmabuf-mmap: SUCCESS (0.013s) [125.247876] [150/162] (879s left) vgem_basic (mmap) [125.309160] Starting subtest: mmap [125.320390] Subtest mmap: SUCCESS (0.012s) [125.384523] [151/162] (879s left) vgem_basic (second-client) [125.446574] Starting subtest: second-client [125.450690] Subtest second-client: SUCCESS (0.005s) [125.511527] [152/162] (879s left) vgem_basic (sysfs) [125.574981] Starting subtest: sysfs [125.575964] Subtest sysfs: SUCCESS (0.001s) [125.635803] [153/162] (879s left) core_hotunplug (unbind-rebind) [125.752690] Starting subtest: unbind-rebind [129.902506] Subtest unbind-rebind: SUCCESS (4.144s) [129.958446] [154/162] (874s left) vgem_basic (unload) [130.023262] Starting subtest: unload [158.991046] Subtest unload: SUCCESS (28.912s) [159.048212] [155/162] (845s left) i915_module_load (reload) [159.110011] Starting subtest: reload [162.695697] Subtest reload: SUCCESS (3.586s) [162.787131] [156/162] (842s left) gem_lmem_swapping (basic) [163.043347] Subtest basic: SKIP (0.000s) [163.154533] [157/162] (842s left) gem_lmem_swapping (parallel-random-engines) [163.221670] Subtest parallel-random-engines: SKIP (0.000s) [163.277816] [158/162] (841s left) gem_lmem_swapping (random-engines) [163.343531] Subtest random-engines: SKIP (0.000s) [163.400631] [159/162] (841s left) gem_lmem_swapping (verify-random) [163.466749] Subtest verify-random: SKIP (0.000s) [163.522449] [160/162] (841s left) i915_pm_rpm (module-reload) [166.541269] Starting subtest: module-reload [181.240592] Subtest module-reload: SUCCESS (14.646s) [181.305725] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [181.307587] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [181.310716] [161/162] (824s left) i915_selftest (live) [181.387943] Starting subtest: live [181.389453] Starting dynamic subtest: sanitycheck [184.170240] Dynamic subtest sanitycheck: SUCCESS (2.727s) [184.182297] Starting dynamic subtest: uncore [186.835175] Dynamic subtest uncore: SUCCESS (2.664s) [186.847236] Starting dynamic subtest: workarounds [189.845406] Dynamic subtest workarounds: SUCCESS (3.009s) [189.860855] Starting dynamic subtest: gt_engines [193.064138] Dynamic subtest gt_engines: SUCCESS (3.218s) [193.076180] Starting dynamic subtest: gt_timelines [208.774430] Dynamic subtest gt_timelines: SUCCESS (15.709s) [208.786532] Starting dynamic subtest: gt_contexts [211.608214] Dynamic subtest gt_contexts: SUCCESS (2.833s) [211.620635] Starting dynamic subtest: gt_lrc [217.539194] Dynamic subtest gt_lrc: SUCCESS (5.930s) [217.551278] Starting dynamic subtest: gt_mocs [220.348758] Dynamic subtest gt_mocs: SUCCESS (2.808s) [220.361059] Starting dynamic subtest: gt_pm [231.736092] Dynamic subtest gt_pm: SUCCESS (11.387s) [231.748185] Starting dynamic subtest: gt_heartbeat [234.394402] Dynamic subtest gt_heartbeat: SUCCESS (2.657s) [234.406532] Starting dynamic subtest: gt_tlb [238.844468] Dynamic subtest gt_tlb: SUCCESS (4.449s) [238.856600] Starting dynamic subtest: requests [249.091455] Dynamic subtest requests: SUCCESS (10.246s) [249.103654] Starting dynamic subtest: migrate [254.704466] Dynamic subtest migrate: SUCCESS (5.611s) [254.716629] Starting dynamic subtest: active [257.461926] Dynamic subtest active: SUCCESS (2.756s) [257.477590] Starting dynamic subtest: objects [261.014940] Dynamic subtest objects: SUCCESS (3.550s) [261.027087] Starting dynamic subtest: mman [267.267539] Dynamic subtest mman: SUCCESS (6.252s) [267.279639] Starting dynamic subtest: dmabuf [269.985394] Dynamic subtest dmabuf: SUCCESS (2.716s) [269.997585] Starting dynamic subtest: vma [272.645016] Dynamic subtest vma: SUCCESS (2.658s) [272.660236] Starting dynamic subtest: coherency [276.452511] Dynamic subtest coherency: SUCCESS (3.805s) [276.468207] Starting dynamic subtest: gtt [286.400065] Dynamic subtest gtt: SUCCESS (9.946s) [286.412255] Starting dynamic subtest: gem [289.630091] Dynamic subtest gem: SUCCESS (3.228s) [289.645718] Starting dynamic subtest: evict [294.608205] Dynamic subtest evict: SUCCESS (4.976s) [294.620383] Starting dynamic subtest: hugepages [303.746366] Dynamic subtest hugepages: SUCCESS (9.136s) [303.758535] Starting dynamic subtest: gem_contexts [323.636561] Dynamic subtest gem_contexts: SUCCESS (19.888s) [323.648810] Starting dynamic subtest: client [326.376375] Dynamic subtest client: SUCCESS (2.738s) [326.391232] Starting dynamic subtest: gem_migrate [329.075417] Dynamic subtest gem_migrate: SUCCESS (2.697s) [329.087683] Starting dynamic subtest: reset [332.216173] Dynamic subtest reset: SUCCESS (3.139s) [332.228328] Starting dynamic subtest: memory_region [334.890380] Dynamic subtest memory_region: SUCCESS (2.672s) [334.902697] Starting dynamic subtest: hangcheck [366.279415] Dynamic subtest hangcheck: SUCCESS (31.386s) [366.295203] Starting dynamic subtest: execlists [381.989116] Dynamic subtest execlists: SUCCESS (15.762s) [382.006150] Starting dynamic subtest: ring_submission [384.638242] Dynamic subtest ring_submission: SUCCESS (2.631s) [384.701420] Starting dynamic subtest: perf [387.393083] Dynamic subtest perf: SUCCESS (2.768s) [387.405477] Starting dynamic subtest: slpc [390.112565] Dynamic subtest slpc: SUCCESS (2.664s) [390.128361] Starting dynamic subtest: guc [392.772528] Dynamic subtest guc: SUCCESS (2.658s) [392.788275] Starting dynamic subtest: guc_multi_lrc [395.436651] Dynamic subtest guc_multi_lrc: SUCCESS (2.662s) [395.452206] Starting dynamic subtest: guc_hang [398.151297] Dynamic subtest guc_hang: SUCCESS (2.713s) [398.163541] Starting dynamic subtest: late_gt_pm [400.890565] Dynamic subtest late_gt_pm: SUCCESS (2.737s) [400.893188] Subtest live: SUCCESS (219.445s) [400.961296] [162/162] (604s left) dmabuf (all-tests) [401.031688] Starting subtest: all-tests [401.033847] Subtest all-tests: SKIP (0.000s) [401.076890] 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.