[38.230717] Initializing watchdogs [38.230803] /dev/watchdog0 [38.257989] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:01:00.0: 1002:694c Polaris 22 XT [Radeon RX Vega M GH] [38.258925] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591b Intel Kabylake (Gen9) HD Graphics 630 [38.263917] [001/162] (960s left) i915_module_load (load) [38.316238] Starting subtest: load [40.637835] Subtest load: SUCCESS (2.323s) [40.688753] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [40.691204] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [40.694210] [002/162] (958s left) core_auth (basic-auth) [40.754220] Starting subtest: basic-auth [40.755279] Subtest basic-auth: SUCCESS (0.001s) [40.806838] [003/162] (958s left) core_debugfs (read-all-entries) [40.859137] Starting subtest: read-all-entries [40.861406] Subtest read-all-entries: SUCCESS (0.003s) [40.911070] [004/162] (958s left) core_sysfs (read-all-entries) [40.957858] Starting subtest: read-all-entries [40.961105] Subtest read-all-entries: SUCCESS (0.004s) [41.010377] [005/162] (957s left) fbdev (eof) [41.066232] Subtest eof: SKIP (0.000s) [41.113384] [006/162] (957s left) fbdev (info) [41.169473] Subtest info: SKIP (0.000s) [41.216610] [007/162] (957s left) fbdev (nullptr) [41.272037] Subtest nullptr: SKIP (0.000s) [41.319608] [008/162] (957s left) fbdev (read) [41.374367] Subtest read: SKIP (0.000s) [41.421897] [009/162] (957s left) fbdev (write) [41.497569] Subtest write: SKIP (0.000s) [41.553186] [010/162] (957s left) gem_basic (bad-close) [41.600148] Starting subtest: bad-close [41.601983] Subtest bad-close: SUCCESS (0.000s) [41.650634] [011/162] (957s left) gem_basic (create-close) [41.695455] Starting subtest: create-close [41.697217] Subtest create-close: SUCCESS (0.000s) [41.775676] [012/162] (957s left) gem_basic (create-fd-close) [41.822110] Starting subtest: create-fd-close [41.824055] Subtest create-fd-close: SUCCESS (0.000s) [41.889979] [013/162] (957s left) gem_busy (busy@all-engines) [41.953165] Starting subtest: busy [41.954133] Starting dynamic subtest: all-engines [41.986381] Dynamic subtest all-engines: SUCCESS (0.034s) [41.987298] Subtest busy: SUCCESS (0.034s) [42.375734] [014/162] (957s left) gem_close_race (basic-process) [42.436650] Starting subtest: basic-process [42.503513] Subtest basic-process: SUCCESS (0.067s) [42.660706] [015/162] (956s left) gem_close_race (basic-threads) [42.721260] Starting subtest: basic-threads [43.934558] Subtest basic-threads: SUCCESS (1.213s) [44.121797] [016/162] (955s left) gem_ctx_create (basic) [44.179970] Starting subtest: basic [44.181147] Subtest basic: SUCCESS (0.000s) [44.340035] [017/162] (955s left) gem_ctx_create (basic-files) [44.402924] Starting subtest: basic-files [46.417987] Subtest basic-files: SUCCESS (2.015s) [46.645790] [018/162] (953s left) gem_ctx_exec (basic) [46.693818] Starting subtest: basic [46.698288] Subtest basic: SUCCESS (0.005s) [46.814722] [019/162] (952s left) gem_exec_basic (basic) [46.868362] Starting subtest: basic [46.870117] Starting dynamic subtest: rcs0-smem [46.872232] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [46.880681] Starting dynamic subtest: bcs0-smem [46.881672] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [46.889330] Starting dynamic subtest: vcs0-smem [46.890377] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [46.898058] Starting dynamic subtest: vecs0-smem [46.899145] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [46.900195] Subtest basic: SUCCESS (0.007s) [47.106911] [020/162] (952s left) gem_exec_create (basic) [47.165309] Starting subtest: basic [47.166176] Starting dynamic subtest: smem [49.228493] Dynamic subtest smem: SUCCESS (2.136s) [49.229387] Subtest basic: SUCCESS (2.136s) [49.412717] [021/162] (950s left) gem_exec_fence (basic-busy) [49.586489] Starting subtest: basic-busy [49.588165] Starting dynamic subtest: rcs0 [49.623642] Dynamic subtest rcs0: SUCCESS (0.038s) [49.642899] Starting dynamic subtest: bcs0 [49.659843] Dynamic subtest bcs0: SUCCESS (0.037s) [49.678092] Starting dynamic subtest: vcs0 [49.701410] Dynamic subtest vcs0: SUCCESS (0.043s) [49.713772] Starting dynamic subtest: vecs0 [49.752803] Dynamic subtest vecs0: SUCCESS (0.053s) [49.754235] Subtest basic-busy: SUCCESS (0.174s) [50.374522] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [50.376607] [022/162] (949s left) gem_exec_fence (basic-wait) [50.547593] Starting subtest: basic-wait [50.548561] Starting dynamic subtest: rcs0 [50.589533] Dynamic subtest rcs0: SUCCESS (0.043s) [50.610369] Starting dynamic subtest: bcs0 [50.622504] Dynamic subtest bcs0: SUCCESS (0.033s) [50.641301] Starting dynamic subtest: vcs0 [50.660207] Dynamic subtest vcs0: SUCCESS (0.038s) [50.670119] Starting dynamic subtest: vecs0 [50.691051] Dynamic subtest vecs0: SUCCESS (0.032s) [50.691997] Subtest basic-wait: SUCCESS (0.149s) [51.245841] [023/162] (948s left) gem_exec_fence (basic-await) [51.431196] Starting subtest: basic-await [51.432644] Starting dynamic subtest: rcs0 [51.527592] Dynamic subtest rcs0: SUCCESS (0.099s) [51.540757] Starting dynamic subtest: bcs0 [51.616035] Dynamic subtest bcs0: SUCCESS (0.091s) [51.630749] Starting dynamic subtest: vcs0 [51.711674] Dynamic subtest vcs0: SUCCESS (0.098s) [51.724604] Starting dynamic subtest: vecs0 [51.801215] Dynamic subtest vecs0: SUCCESS (0.092s) [51.802268] Subtest basic-await: SUCCESS (0.383s) [52.398122] [024/162] (947s left) gem_exec_fence (nb-await) [52.588284] Starting subtest: nb-await [52.589836] Starting dynamic subtest: rcs0 [52.659841] Dynamic subtest rcs0: SUCCESS (0.075s) [52.671136] Starting dynamic subtest: bcs0 [52.722204] Dynamic subtest bcs0: SUCCESS (0.063s) [52.739841] Starting dynamic subtest: vcs0 [52.790715] Dynamic subtest vcs0: SUCCESS (0.069s) [52.809673] Starting dynamic subtest: vecs0 [52.860161] Dynamic subtest vecs0: SUCCESS (0.070s) [52.861640] Subtest nb-await: SUCCESS (0.282s) [53.394360] [025/162] (946s left) gem_exec_gttfill (basic) [53.453261] Starting subtest: basic [57.662384] Subtest basic: SUCCESS (4.289s) [57.859689] [026/162] (942s left) gem_exec_parallel (engines) [57.966772] Starting subtest: engines [57.967606] Starting dynamic subtest: basic [60.348450] Dynamic subtest basic: SUCCESS (2.395s) [60.357287] Starting dynamic subtest: contexts [64.797330] Dynamic subtest contexts: SUCCESS (4.496s) [64.806538] Starting dynamic subtest: fds [66.798551] Dynamic subtest fds: SUCCESS (2.010s) [66.808630] Starting dynamic subtest: userptr [69.303879] Dynamic subtest userptr: SUCCESS (2.500s) [69.304964] Subtest engines: SUCCESS (11.403s) [69.493491] [027/162] (930s left) gem_exec_store (basic) [69.553551] Starting subtest: basic [69.634643] Subtest basic: SUCCESS (0.081s) [69.832876] [028/162] (930s left) gem_flink_basic (bad-flink) [69.879063] Starting subtest: bad-flink [69.880105] Subtest bad-flink: SUCCESS (0.000s) [69.935125] [029/162] (930s left) gem_flink_basic (bad-open) [69.980873] Starting subtest: bad-open [69.981935] Subtest bad-open: SUCCESS (0.000s) [70.036872] [030/162] (930s left) gem_flink_basic (basic) [70.083112] Starting subtest: basic [70.084096] Subtest basic: SUCCESS (0.000s) [70.176817] [031/162] (930s left) gem_flink_basic (double-flink) [70.223394] Starting subtest: double-flink [70.224304] Subtest double-flink: SUCCESS (0.000s) [70.317423] [032/162] (930s left) gem_flink_basic (flink-lifetime) [70.362040] Starting subtest: flink-lifetime [70.362988] Subtest flink-lifetime: SUCCESS (0.001s) [70.459730] [033/162] (930s left) gem_huc_copy (huc-copy) [70.513130] Starting subtest: huc-copy [70.514966] Subtest huc-copy: SKIP (0.000s) [70.643551] [034/162] (930s left) gem_linear_blits (basic) [70.791553] Starting subtest: basic [70.802178] Subtest basic: SUCCESS (0.011s) [70.945651] [035/162] (930s left) gem_mmap (basic) [71.045070] Starting subtest: basic [71.050301] Subtest basic: SUCCESS (0.000s) [71.118669] [036/162] (929s left) gem_mmap_gtt (basic) [71.165721] Starting subtest: basic [71.166779] Subtest basic: SUCCESS (0.001s) [71.222555] [037/162] (929s left) gem_render_linear_blits (basic) [71.277314] Starting subtest: basic [71.308965] Subtest basic: SUCCESS (0.033s) [71.381490] [038/162] (929s left) gem_render_tiled_blits (basic) [71.438193] Starting subtest: basic [71.474700] Subtest basic: SUCCESS (0.037s) [71.541749] [039/162] (929s left) gem_ringfill (basic-all) [71.794305] Starting subtest: basic-all [72.933132] Subtest basic-all: SUCCESS (1.139s) [73.056396] [040/162] (928s left) gem_softpin (allocator-basic) [73.109943] Starting subtest: allocator-basic [73.235947] Subtest allocator-basic: SUCCESS (0.123s) [73.330543] [041/162] (927s left) gem_softpin (allocator-basic-reserve) [73.385021] Starting subtest: allocator-basic-reserve [73.511788] Subtest allocator-basic-reserve: SUCCESS (0.123s) [73.604687] [042/162] (927s left) gem_softpin (safe-alignment) [73.659423] Starting subtest: safe-alignment [73.671979] Subtest safe-alignment: SUCCESS (0.012s) [73.808682] [043/162] (927s left) gem_sync (basic-all) [73.867570] Starting subtest: basic-all [76.144346] Subtest basic-all: SUCCESS (2.280s) [76.307746] [044/162] (925s left) gem_sync (basic-each) [76.366110] Starting subtest: basic-each [78.472100] Subtest basic-each: SUCCESS (2.108s) [78.703424] [045/162] (922s left) gem_tiled_blits (basic) [78.811028] Starting subtest: basic [78.827870] Subtest basic: SUCCESS (0.017s) [78.931956] [046/162] (922s left) gem_tiled_fence_blits (basic) [79.123623] Starting subtest: basic [79.132839] Subtest basic: SUCCESS (0.009s) [79.275834] [047/162] (922s left) gem_tiled_pread_basic [79.530666] [048/162] (922s left) gem_wait (busy@all-engines) [79.594792] Starting subtest: busy [79.595722] Starting dynamic subtest: all-engines [80.115439] Dynamic subtest all-engines: SUCCESS (0.520s) [80.116476] Subtest busy: SUCCESS (0.521s) [80.298698] [049/162] (921s left) gem_wait (wait@all-engines) [80.362359] Starting subtest: wait [80.363394] Starting dynamic subtest: all-engines [81.393651] Dynamic subtest all-engines: SUCCESS (1.030s) [81.395264] Subtest wait: SUCCESS (1.031s) [81.599375] [050/162] (920s left) i915_getparams_basic (basic-eu-total) [81.646354] Starting subtest: basic-eu-total [81.648300] Subtest basic-eu-total: SUCCESS (0.000s) [81.720485] [051/162] (920s left) i915_getparams_basic (basic-subslice-total) [81.766487] Starting subtest: basic-subslice-total [81.768459] Subtest basic-subslice-total: SUCCESS (0.000s) [81.822822] [052/162] (920s left) i915_hangman (error-state-basic) [81.882355] Starting subtest: error-state-basic [81.888488] Subtest error-state-basic: SUCCESS (0.006s) [81.978730] [053/162] (920s left) i915_pciid [82.079436] [054/162] (920s left) intel_hwmon (hwmon-read) [82.125783] Subtest hwmon-read: SKIP (0.000s) [82.180623] [055/162] (920s left) intel_hwmon (hwmon-write) [82.228964] Subtest hwmon-write: SKIP (0.000s) [82.284688] [056/162] (920s left) kms_addfb_basic (addfb25-4-tiled) [82.970120] Starting subtest: addfb25-4-tiled [82.971089] Subtest addfb25-4-tiled: SUCCESS (0.000s) [83.052750] [057/162] (919s left) kms_addfb_basic (addfb25-bad-modifier) [83.724914] Starting subtest: addfb25-bad-modifier [83.725810] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [83.810682] [058/162] (918s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [84.484228] Starting subtest: addfb25-framebuffer-vs-set-tiling [84.485302] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.578362] [059/162] (917s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.253013] Starting subtest: addfb25-modifier-no-flag [85.254020] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.327812] [060/162] (917s left) kms_addfb_basic (addfb25-x-tiled-legacy) [86.000170] Starting subtest: addfb25-x-tiled-legacy [86.001080] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [86.090717] [061/162] (916s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [86.760080] Starting subtest: addfb25-x-tiled-mismatch-legacy [86.760998] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [86.836991] [062/162] (915s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [87.526879] Starting subtest: addfb25-yf-tiled-legacy [87.527877] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [87.632181] [063/162] (915s left) kms_addfb_basic (addfb25-y-tiled-legacy) [88.311342] Starting subtest: addfb25-y-tiled-legacy [88.312279] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [88.415381] [064/162] (914s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [89.088272] Starting subtest: addfb25-y-tiled-small-legacy [89.089288] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [89.172651] [065/162] (913s left) kms_addfb_basic (bad-pitch-0) [89.219290] Starting subtest: bad-pitch-0 [89.220264] Subtest bad-pitch-0: SUCCESS (0.000s) [89.929434] [066/162] (913s left) kms_addfb_basic (bad-pitch-1024) [89.976104] Starting subtest: bad-pitch-1024 [89.977047] Subtest bad-pitch-1024: SUCCESS (0.000s) [90.693817] [067/162] (912s left) kms_addfb_basic (bad-pitch-128) [90.739326] Starting subtest: bad-pitch-128 [90.740228] Subtest bad-pitch-128: SUCCESS (0.000s) [91.443901] [068/162] (911s left) kms_addfb_basic (bad-pitch-256) [91.490165] Starting subtest: bad-pitch-256 [91.491189] Subtest bad-pitch-256: SUCCESS (0.000s) [92.196918] [069/162] (910s left) kms_addfb_basic (bad-pitch-32) [92.241972] Starting subtest: bad-pitch-32 [92.242797] Subtest bad-pitch-32: SUCCESS (0.000s) [92.958413] [070/162] (910s left) kms_addfb_basic (bad-pitch-63) [93.004890] Starting subtest: bad-pitch-63 [93.005836] Subtest bad-pitch-63: SUCCESS (0.000s) [93.728338] [071/162] (909s left) kms_addfb_basic (bad-pitch-65536) [93.775144] Starting subtest: bad-pitch-65536 [93.776117] Subtest bad-pitch-65536: SUCCESS (0.000s) [94.482310] [072/162] (908s left) kms_addfb_basic (bad-pitch-999) [94.530301] Starting subtest: bad-pitch-999 [94.531247] Subtest bad-pitch-999: SUCCESS (0.000s) [95.251559] [073/162] (908s left) kms_addfb_basic (basic) [95.300452] Starting subtest: basic [95.301372] Subtest basic: SUCCESS (0.000s) [96.026417] [074/162] (907s left) kms_addfb_basic (basic-x-tiled-legacy) [96.076405] Starting subtest: basic-x-tiled-legacy [96.077230] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [96.782692] [075/162] (906s left) kms_addfb_basic (basic-y-tiled-legacy) [96.830901] Starting subtest: basic-y-tiled-legacy [96.831801] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [97.545402] [076/162] (906s left) kms_addfb_basic (bo-too-small) [98.216948] Starting subtest: bo-too-small [98.217962] Subtest bo-too-small: SUCCESS (0.000s) [98.294600] [077/162] (905s left) kms_addfb_basic (bo-too-small-due-to-tiling) [98.966283] Starting subtest: bo-too-small-due-to-tiling [98.967346] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [99.053400] [078/162] (904s left) kms_addfb_basic (clobberred-modifier) [99.099928] Starting subtest: clobberred-modifier [99.100948] Subtest clobberred-modifier: SUCCESS (0.000s) [99.822407] [079/162] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [99.869403] Starting subtest: framebuffer-vs-set-tiling [99.870219] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.582734] [080/162] (903s left) kms_addfb_basic (invalid-get-prop) [100.630975] Starting subtest: invalid-get-prop [100.631927] Subtest invalid-get-prop: SUCCESS (0.000s) [101.352685] [081/162] (902s left) kms_addfb_basic (invalid-get-prop-any) [101.399037] Starting subtest: invalid-get-prop-any [101.399994] Subtest invalid-get-prop-any: SUCCESS (0.000s) [102.120428] [082/162] (901s left) kms_addfb_basic (invalid-set-prop) [102.167783] Starting subtest: invalid-set-prop [102.168739] Subtest invalid-set-prop: SUCCESS (0.000s) [102.923794] [083/162] (901s left) kms_addfb_basic (invalid-set-prop-any) [102.969666] Starting subtest: invalid-set-prop-any [102.970602] Subtest invalid-set-prop-any: SUCCESS (0.000s) [103.671945] [084/162] (900s left) kms_addfb_basic (no-handle) [103.717703] Starting subtest: no-handle [103.718518] Subtest no-handle: SUCCESS (0.000s) [104.421442] [085/162] (899s left) kms_addfb_basic (size-max) [105.099760] Starting subtest: size-max [105.100744] Subtest size-max: SUCCESS (0.000s) [105.193621] [086/162] (899s left) kms_addfb_basic (small-bo) [105.865313] Starting subtest: small-bo [105.866402] Subtest small-bo: SUCCESS (0.000s) [105.941839] [087/162] (898s left) kms_addfb_basic (tile-pitch-mismatch) [105.988598] Starting subtest: tile-pitch-mismatch [105.989582] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.695661] [088/162] (897s left) kms_addfb_basic (too-high) [107.367953] Starting subtest: too-high [107.369030] Subtest too-high: SUCCESS (0.001s) [107.450309] [089/162] (896s left) kms_addfb_basic (too-wide) [108.131700] Starting subtest: too-wide [108.132608] Subtest too-wide: SUCCESS (0.000s) [108.210937] [090/162] (896s left) kms_addfb_basic (unused-handle) [108.257399] Starting subtest: unused-handle [108.258247] Subtest unused-handle: SUCCESS (0.000s) [108.972691] [091/162] (895s left) kms_addfb_basic (unused-modifier) [109.021073] Starting subtest: unused-modifier [109.022044] Subtest unused-modifier: SUCCESS (0.000s) [109.726508] [092/162] (894s left) kms_addfb_basic (unused-offsets) [109.772596] Starting subtest: unused-offsets [109.773528] Subtest unused-offsets: SUCCESS (0.000s) [110.483397] [093/162] (894s left) kms_addfb_basic (unused-pitches) [110.530468] Starting subtest: unused-pitches [110.531427] Subtest unused-pitches: SUCCESS (0.000s) [111.253309] [094/162] (893s left) kms_busy (basic) [111.906461] Subtest basic: SKIP (0.000s) [111.961760] [095/162] (892s left) kms_prop_blob (basic) [112.010184] Starting subtest: basic [112.011147] Subtest basic: SUCCESS (0.000s) [112.067369] [096/162] (892s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [112.756338] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [112.809314] [097/162] (892s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [113.490881] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [113.544476] [098/162] (891s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.233418] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [114.288560] [099/162] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [114.974896] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [115.027917] [100/162] (889s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [115.705043] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [115.757594] [101/162] (889s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [116.442973] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [116.496150] [102/162] (888s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [117.176168] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [117.231702] [103/162] (887s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [117.909337] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [117.962972] [104/162] (887s left) kms_dsc (dsc-basic) [118.643343] Subtest dsc-basic: SKIP (0.000s) [118.699952] [105/162] (886s left) kms_flip (basic-flip-vs-dpms) [119.370381] Starting subtest: basic-flip-vs-dpms [119.373364] Subtest basic-flip-vs-dpms: SKIP (0.002s) [119.438734] [106/162] (885s left) kms_flip (basic-flip-vs-modeset) [120.108433] Starting subtest: basic-flip-vs-modeset [120.111939] Subtest basic-flip-vs-modeset: SKIP (0.003s) [120.177760] [107/162] (885s left) kms_flip (basic-flip-vs-wf_vblank) [120.860187] Starting subtest: basic-flip-vs-wf_vblank [120.862981] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [120.929918] [108/162] (884s left) kms_flip (basic-plain-flip) [121.604016] Starting subtest: basic-plain-flip [121.607270] Subtest basic-plain-flip: SKIP (0.003s) [121.672578] [109/162] (883s left) kms_force_connector_basic (force-connector-state) [122.425270] Starting subtest: force-connector-state [123.795972] Subtest force-connector-state: SUCCESS (1.371s) [125.089330] [110/162] (880s left) kms_force_connector_basic (force-edid) [125.837240] Starting subtest: force-edid [126.425447] Subtest force-edid: SUCCESS (0.588s) [127.716783] [111/162] (877s left) kms_force_connector_basic (force-load-detect) [128.480570] Starting subtest: force-load-detect [128.482741] Subtest force-load-detect: SKIP (0.000s) [129.460066] [112/162] (876s left) kms_force_connector_basic (prune-stale-modes) [130.215321] Starting subtest: prune-stale-modes [130.894695] Subtest prune-stale-modes: SUCCESS (0.680s) [132.194700] [113/162] (873s left) kms_frontbuffer_tracking (basic) [132.868061] Subtest basic: SKIP (0.000s) [132.947326] [114/162] (872s left) kms_hdmi_inject (inject-audio) [132.996278] Starting subtest: inject-audio [133.580301] Subtest inject-audio: SUCCESS (0.583s) [134.006291] [115/162] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [134.674737] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [134.738375] [116/162] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [135.410720] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [135.470215] [117/162] (870s left) kms_pipe_crc_basic (hang-read-crc) [136.140281] Subtest hang-read-crc: SKIP (0.000s) [136.199550] [118/162] (869s left) kms_pipe_crc_basic (nonblocking-crc) [136.870114] Subtest nonblocking-crc: SKIP (0.000s) [136.928891] [119/162] (869s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [137.605825] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [137.665870] [120/162] (868s left) kms_pipe_crc_basic (read-crc) [138.343382] Subtest read-crc: SKIP (0.000s) [138.402033] [121/162] (867s left) kms_pipe_crc_basic (read-crc-frame-sequence) [139.078406] Subtest read-crc-frame-sequence: SKIP (0.000s) [139.137548] [122/162] (867s left) kms_pm_backlight (basic-brightness) [139.816029] Subtest basic-brightness: SKIP (0.000s) [139.875619] [123/162] (866s left) kms_pm_rpm (basic-pci-d3-state) [142.336868] Starting subtest: basic-pci-d3-state [142.850249] Subtest basic-pci-d3-state: SUCCESS (0.515s) [143.195231] [124/162] (863s left) kms_pm_rpm (basic-rte) [143.240933] Starting subtest: basic-rte [146.102879] Subtest basic-rte: SUCCESS (2.863s) [146.894220] [125/162] (859s left) kms_psr (psr-primary-page-flip) [147.572196] Subtest psr-primary-page-flip: SKIP (0.000s) [147.631398] [126/162] (858s left) kms_psr (psr-cursor-plane-move) [148.311309] Subtest psr-cursor-plane-move: SKIP (0.000s) [148.389888] [127/162] (858s left) kms_psr (psr-sprite-plane-onoff) [149.063858] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [149.121854] [128/162] (857s left) kms_psr (psr-primary-mmap-gtt) [149.793216] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [149.852765] [129/162] (856s left) kms_setmode (basic-clone-single-crtc) [149.900267] Starting subtest: basic-clone-single-crtc [149.903044] Subtest basic-clone-single-crtc: SKIP (0.000s) [149.965309] [130/162] (856s left) i915_pm_rps (basic-api) [150.021643] Starting subtest: basic-api [150.025970] Subtest basic-api: SUCCESS (0.004s) [150.085405] [131/162] (856s left) prime_self_import (basic-llseek-bad) [150.131181] Starting subtest: basic-llseek-bad [150.133124] Subtest basic-llseek-bad: SUCCESS (0.002s) [150.218404] [132/162] (856s left) prime_self_import (basic-llseek-size) [150.264397] Starting subtest: basic-llseek-size [150.267640] Subtest basic-llseek-size: SUCCESS (0.004s) [150.354784] [133/162] (856s left) prime_self_import (basic-with_fd_dup) [150.400528] Starting subtest: basic-with_fd_dup [150.403809] Subtest basic-with_fd_dup: SUCCESS (0.003s) [150.501780] [134/162] (856s left) prime_self_import (basic-with_one_bo) [150.546039] Starting subtest: basic-with_one_bo [150.549206] Subtest basic-with_one_bo: SUCCESS (0.003s) [150.609551] [135/162] (856s left) prime_self_import (basic-with_one_bo_two_files) [150.655710] Starting subtest: basic-with_one_bo_two_files [150.657673] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [150.745337] [136/162] (856s left) prime_self_import (basic-with_two_bos) [150.790868] Starting subtest: basic-with_two_bos [150.793840] Subtest basic-with_two_bos: SUCCESS (0.003s) [150.872287] [137/162] (856s left) prime_vgem (basic-fence-flip) [150.926954] Starting subtest: basic-fence-flip [151.552611] Subtest basic-fence-flip: SKIP (0.625s) [151.616389] [138/162] (855s left) prime_vgem (basic-fence-mmap) [151.671486] Starting subtest: basic-fence-mmap [151.696735] Subtest basic-fence-mmap: SUCCESS (0.025s) [151.819811] [139/162] (855s left) prime_vgem (basic-fence-read) [151.873044] Starting subtest: basic-fence-read [151.930048] Subtest basic-fence-read: SUCCESS (0.057s) [152.026998] [140/162] (855s left) prime_vgem (basic-gtt) [152.080475] Starting subtest: basic-gtt [152.093271] Subtest basic-gtt: SUCCESS (0.012s) [152.178428] [141/162] (855s left) prime_vgem (basic-read) [152.232675] Starting subtest: basic-read [152.260143] Subtest basic-read: SUCCESS (0.028s) [152.347803] [142/162] (855s left) prime_vgem (basic-write) [152.403193] Starting subtest: basic-write [152.431186] Subtest basic-write: SUCCESS (0.029s) [152.529767] [143/162] (855s left) vgem_basic (setversion) [152.579183] Starting subtest: setversion [152.581197] Subtest setversion: SUCCESS (0.000s) [152.638326] [144/162] (855s left) vgem_basic (create) [152.688963] Starting subtest: create [152.689817] Subtest create: SUCCESS (0.000s) [152.746727] [145/162] (854s left) vgem_basic (debugfs) [152.793891] Starting subtest: debugfs [152.794771] Subtest debugfs: SUCCESS (0.000s) [152.852956] [146/162] (854s left) vgem_basic (dmabuf-export) [152.900947] Starting subtest: dmabuf-export [152.902503] Subtest dmabuf-export: SUCCESS (0.002s) [152.987748] [147/162] (854s left) vgem_basic (dmabuf-fence) [153.036317] Starting subtest: dmabuf-fence [153.037190] Subtest dmabuf-fence: SUCCESS (0.001s) [153.098859] [148/162] (854s left) vgem_basic (dmabuf-fence-before) [153.146803] Starting subtest: dmabuf-fence-before [153.147756] Subtest dmabuf-fence-before: SUCCESS (0.000s) [153.205795] [149/162] (854s left) vgem_basic (dmabuf-mmap) [153.254487] Starting subtest: dmabuf-mmap [153.264443] Subtest dmabuf-mmap: SUCCESS (0.011s) [153.323362] [150/162] (854s left) vgem_basic (mmap) [153.371772] Starting subtest: mmap [153.378828] Subtest mmap: SUCCESS (0.008s) [153.436790] [151/162] (854s left) vgem_basic (second-client) [153.485863] Starting subtest: second-client [153.489217] Subtest second-client: SUCCESS (0.003s) [153.547246] [152/162] (854s left) vgem_basic (sysfs) [153.595456] Starting subtest: sysfs [153.596462] Subtest sysfs: SUCCESS (0.001s) [153.654241] [153/162] (854s left) core_hotunplug (unbind-rebind) [153.745637] Starting subtest: unbind-rebind [158.270558] Subtest unbind-rebind: SUCCESS (4.525s) [158.329225] [154/162] (849s left) vgem_basic (unload) [158.374567] Starting subtest: unload [187.305287] Subtest unload: SUCCESS (28.927s) [187.383396] [155/162] (820s left) i915_module_load (reload) [187.428149] Starting subtest: reload [190.989832] Subtest reload: SUCCESS (3.562s) [191.105867] [156/162] (817s left) gem_lmem_swapping (basic) [191.168322] Subtest basic: SKIP (0.000s) [191.225116] [157/162] (817s left) gem_lmem_swapping (parallel-random-engines) [191.277400] Subtest parallel-random-engines: SKIP (0.000s) [191.332543] [158/162] (817s left) gem_lmem_swapping (random-engines) [191.383492] Subtest random-engines: SKIP (0.000s) [191.439936] [159/162] (817s left) gem_lmem_swapping (verify-random) [191.491472] Subtest verify-random: SKIP (0.000s) [191.547907] [160/162] (817s left) i915_pm_rpm (module-reload) [193.860347] Starting subtest: module-reload [205.014270] Subtest module-reload: SUCCESS (11.152s) [205.054947] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [205.056257] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [205.058393] [161/162] (803s left) i915_selftest (live) [205.108728] Starting subtest: live [205.109706] Starting dynamic subtest: sanitycheck [207.329171] Dynamic subtest sanitycheck: SUCCESS (2.217s) [207.339019] Starting dynamic subtest: uncore [209.524409] Dynamic subtest uncore: SUCCESS (2.194s) [209.534943] Starting dynamic subtest: workarounds [212.009099] Dynamic subtest workarounds: SUCCESS (2.484s) [212.018179] Starting dynamic subtest: gt_engines [214.705257] Dynamic subtest gt_engines: SUCCESS (2.695s) [214.714563] Starting dynamic subtest: gt_timelines [225.202214] Dynamic subtest gt_timelines: SUCCESS (10.496s) [225.211529] Starting dynamic subtest: gt_contexts [227.618033] Dynamic subtest gt_contexts: SUCCESS (2.415s) [227.631876] Starting dynamic subtest: gt_lrc [232.364195] Dynamic subtest gt_lrc: SUCCESS (4.745s) [232.374884] Starting dynamic subtest: gt_mocs [234.816271] Dynamic subtest gt_mocs: SUCCESS (2.451s) [234.825855] Starting dynamic subtest: gt_pm [241.540108] Dynamic subtest gt_pm: SUCCESS (6.722s) [241.550510] Starting dynamic subtest: gt_heartbeat [243.800103] Dynamic subtest gt_heartbeat: SUCCESS (2.259s) [243.810064] Starting dynamic subtest: gt_tlb [247.260059] Dynamic subtest gt_tlb: SUCCESS (3.459s) [247.272916] Starting dynamic subtest: requests [255.742327] Dynamic subtest requests: SUCCESS (8.481s) [255.751279] Starting dynamic subtest: migrate [261.198331] Dynamic subtest migrate: SUCCESS (5.455s) [261.209465] Starting dynamic subtest: active [263.440104] Dynamic subtest active: SUCCESS (2.240s) [263.452170] Starting dynamic subtest: objects [266.386635] Dynamic subtest objects: SUCCESS (2.945s) [266.398723] Starting dynamic subtest: mman [272.030689] Dynamic subtest mman: SUCCESS (5.645s) [272.041891] Starting dynamic subtest: dmabuf [274.364254] Dynamic subtest dmabuf: SUCCESS (2.329s) [274.373960] Starting dynamic subtest: vma [276.624173] Dynamic subtest vma: SUCCESS (2.258s) [276.633486] Starting dynamic subtest: coherency [279.861266] Dynamic subtest coherency: SUCCESS (3.235s) [279.871238] Starting dynamic subtest: gtt [289.229237] Dynamic subtest gtt: SUCCESS (9.367s) [289.240551] Starting dynamic subtest: gem [291.585225] Dynamic subtest gem: SUCCESS (2.354s) [291.594739] Starting dynamic subtest: evict [295.281075] Dynamic subtest evict: SUCCESS (3.694s) [295.290620] Starting dynamic subtest: hugepages [297.949813] Warning: kernel log ringbuffer underflow, some records lost. [306.190950] Disk usage limit exceeded. [317.666288] Warning: kernel log ringbuffer underflow, some records lost. [317.940113] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2166 [max: 8192] dynamic-keys: 325 direct dependencies: 22704 [max: 524288] indirect dependencies: 189614 all direct dependencies: 484436 dependency chains: 32575 [max: 524288] dependency chain hlocks used: 133917 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 193 in-softirq chains: 743 in-process chains: 31639 stack-trace entries: 328678 [max: 524288] number of stack traces: 13991 number of stack hash chains: 9447 combined max dependencies: 271823744 hardirq-safe locks: 103 hardirq-unsafe locks: 1297 softirq-safe locks: 232 softirq-unsafe locks: 1191 irq-safe locks: 253 irq-unsafe locks: 1297 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 412 softirq-read-safe locks: 10 softirq-read-unsafe locks: 409 irq-read-safe locks: 11 irq-read-unsafe locks: 412 uncategorized locks: 361 unused locks: 1 max locking depth: 16 max bfs queue depth: 385 max lock class index: 2218 debug_locks: 0 zapped classes: 2662 zapped lock chains: 30288 large chain blocks: 1 [317.994598] [FACT i915_selftest (live)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [317.996611] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_die: true [317.996638] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_warn: true [317.996984] [FACT i915_selftest (live)] new: kernel.kmod_is_loaded.i915: true [317.999657] 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 results: no output, setting notrun Done.