[22.531191] Initializing watchdogs [22.531265] /dev/watchdog0 [22.545972] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [22.552849] [001/162] (960s left) i915_module_load (load) [22.973722] Starting subtest: load [24.993384] Subtest load: SUCCESS (2.019s) [25.029881] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [25.031100] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [25.035522] [002/162] (958s left) core_auth (basic-auth) [25.089698] Starting subtest: basic-auth [25.092661] Subtest basic-auth: SUCCESS (0.001s) [25.130356] [003/162] (958s left) core_debugfs (read-all-entries) [25.179671] Starting subtest: read-all-entries [25.183221] Subtest read-all-entries: SUCCESS (0.002s) [25.223797] [004/162] (957s left) core_sysfs (read-all-entries) [25.275171] Starting subtest: read-all-entries [25.278343] Subtest read-all-entries: SUCCESS (0.003s) [25.315972] [005/162] (957s left) fbdev (eof) [25.370954] Subtest eof: SKIP (0.000s) [25.408337] [006/162] (957s left) fbdev (info) [25.459762] Subtest info: SKIP (0.000s) [25.497053] [007/162] (957s left) fbdev (nullptr) [25.547631] Subtest nullptr: SKIP (0.000s) [25.585443] [008/162] (957s left) fbdev (read) [25.639762] Subtest read: SKIP (0.000s) [25.677763] [009/162] (957s left) fbdev (write) [25.731534] Subtest write: SKIP (0.000s) [25.768779] [010/162] (957s left) gem_basic (bad-close) [25.819486] Starting subtest: bad-close [25.826160] Subtest bad-close: SUCCESS (0.000s) [25.863372] [011/162] (957s left) gem_basic (create-close) [25.913648] Starting subtest: create-close [25.920088] Subtest create-close: SUCCESS (0.000s) [25.964466] [012/162] (957s left) gem_basic (create-fd-close) [26.012570] Starting subtest: create-fd-close [26.018678] Subtest create-fd-close: SUCCESS (0.000s) [26.068254] [013/162] (957s left) gem_busy (busy@all-engines) [26.128400] Starting subtest: busy [26.131773] Starting dynamic subtest: all-engines [26.154656] Dynamic subtest all-engines: SUCCESS (0.026s) [26.157943] Subtest busy: SUCCESS (0.027s) [26.481956] [014/162] (957s left) gem_close_race (basic-process) [26.540565] Starting subtest: basic-process [26.603664] Subtest basic-process: SUCCESS (0.063s) [26.747619] [015/162] (956s left) gem_close_race (basic-threads) [26.801618] Starting subtest: basic-threads [28.104679] Subtest basic-threads: SUCCESS (1.303s) [28.256596] [016/162] (955s left) gem_ctx_create (basic) [28.315331] Starting subtest: basic [28.318537] Subtest basic: SUCCESS (0.000s) [28.457256] [017/162] (955s left) gem_ctx_create (basic-files) [28.511184] Starting subtest: basic-files [30.525661] Subtest basic-files: SUCCESS (2.012s) [31.142444] [018/162] (952s left) gem_ctx_exec (basic) [31.507879] Starting subtest: basic [31.571963] Subtest basic: SUCCESS (0.004s) [32.021646] [019/162] (952s left) gem_exec_basic (basic) [32.079980] Starting subtest: basic [32.083172] Starting dynamic subtest: rcs0-smem [32.086350] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [32.096504] Starting dynamic subtest: bcs0-smem [32.099538] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [32.109656] Starting dynamic subtest: vcs0-smem [32.112444] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [32.122163] Starting dynamic subtest: vecs0-smem [32.125356] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [32.128536] Subtest basic: SUCCESS (0.006s) [32.274051] [020/162] (952s left) gem_exec_create (basic) [32.328630] Starting subtest: basic [32.332037] Starting dynamic subtest: smem [34.381437] Dynamic subtest smem: SUCCESS (2.053s) [34.384706] Subtest basic: SUCCESS (2.053s) [34.528796] [021/162] (950s left) gem_exec_fence (basic-busy) [34.697296] Starting subtest: basic-busy [34.700715] Starting dynamic subtest: rcs0 [34.734485] Dynamic subtest rcs0: SUCCESS (0.037s) [34.756653] Starting dynamic subtest: bcs0 [34.778358] Dynamic subtest bcs0: SUCCESS (0.044s) [34.796080] Starting dynamic subtest: vcs0 [34.815111] Dynamic subtest vcs0: SUCCESS (0.036s) [34.825973] Starting dynamic subtest: vecs0 [34.845272] Dynamic subtest vecs0: SUCCESS (0.030s) [34.848464] Subtest basic-busy: SUCCESS (0.148s) [35.373957] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [35.377988] [022/162] (949s left) gem_exec_fence (basic-wait) [35.552451] Starting subtest: basic-wait [35.555783] Starting dynamic subtest: rcs0 [35.579183] Dynamic subtest rcs0: SUCCESS (0.030s) [35.592126] Starting dynamic subtest: bcs0 [35.620588] Dynamic subtest bcs0: SUCCESS (0.041s) [35.638713] Starting dynamic subtest: vcs0 [35.648508] Dynamic subtest vcs0: SUCCESS (0.028s) [35.665166] Starting dynamic subtest: vecs0 [35.676428] Dynamic subtest vecs0: SUCCESS (0.028s) [35.679922] Subtest basic-wait: SUCCESS (0.127s) [36.172669] [023/162] (948s left) gem_exec_fence (basic-await) [36.343251] Starting subtest: basic-await [36.346264] Starting dynamic subtest: rcs0 [36.418484] Dynamic subtest rcs0: SUCCESS (0.078s) [36.436625] Starting dynamic subtest: bcs0 [36.501249] Dynamic subtest bcs0: SUCCESS (0.082s) [36.516471] Starting dynamic subtest: vcs0 [36.584184] Dynamic subtest vcs0: SUCCESS (0.082s) [36.605937] Starting dynamic subtest: vecs0 [36.675546] Dynamic subtest vecs0: SUCCESS (0.091s) [36.678833] Subtest basic-await: SUCCESS (0.336s) [37.178806] [024/162] (947s left) gem_exec_fence (nb-await) [37.348947] Starting subtest: nb-await [37.352061] Starting dynamic subtest: rcs0 [37.409402] Dynamic subtest rcs0: SUCCESS (0.060s) [37.431536] Starting dynamic subtest: bcs0 [37.474329] Dynamic subtest bcs0: SUCCESS (0.064s) [37.496322] Starting dynamic subtest: vcs0 [37.539282] Dynamic subtest vcs0: SUCCESS (0.064s) [37.561552] Starting dynamic subtest: vecs0 [37.603566] Dynamic subtest vecs0: SUCCESS (0.063s) [37.607184] Subtest nb-await: SUCCESS (0.255s) [38.101366] [025/162] (946s left) gem_exec_gttfill (basic) [38.159596] Starting subtest: basic [41.748546] Subtest basic: SUCCESS (3.592s) [41.913722] [026/162] (942s left) gem_exec_parallel (engines) [42.044410] Starting subtest: engines [42.047508] Starting dynamic subtest: basic [44.149834] Dynamic subtest basic: SUCCESS (2.106s) [44.161526] Starting dynamic subtest: contexts [48.568559] Dynamic subtest contexts: SUCCESS (4.460s) [48.580156] Starting dynamic subtest: fds [50.644096] Dynamic subtest fds: SUCCESS (2.093s) [50.656447] Starting dynamic subtest: userptr [52.902698] Dynamic subtest userptr: SUCCESS (2.275s) [52.905677] Subtest engines: SUCCESS (10.935s) [53.069748] [027/162] (931s left) gem_exec_store (basic) [53.140858] Starting subtest: basic [53.190456] Subtest basic: SUCCESS (0.056s) [53.342391] [028/162] (931s left) gem_flink_basic (bad-flink) [53.390865] Starting subtest: bad-flink [53.394094] Subtest bad-flink: SUCCESS (0.000s) [53.439879] [029/162] (931s left) gem_flink_basic (bad-open) [53.487096] Starting subtest: bad-open [53.490174] Subtest bad-open: SUCCESS (0.000s) [53.533375] [030/162] (931s left) gem_flink_basic (basic) [53.581035] Starting subtest: basic [53.584159] Subtest basic: SUCCESS (0.000s) [53.641704] [031/162] (931s left) gem_flink_basic (double-flink) [53.687173] Starting subtest: double-flink [53.690157] Subtest double-flink: SUCCESS (0.000s) [53.740366] [032/162] (931s left) gem_flink_basic (flink-lifetime) [53.791541] Starting subtest: flink-lifetime [53.794535] Subtest flink-lifetime: SUCCESS (0.001s) [53.851175] [033/162] (931s left) gem_huc_copy (huc-copy) [53.904522] Starting subtest: huc-copy [53.910960] Subtest huc-copy: SKIP (0.000s) [53.972641] [034/162] (931s left) gem_linear_blits (basic) [54.095236] Starting subtest: basic [54.105057] Subtest basic: SUCCESS (0.010s) [54.208210] [035/162] (931s left) gem_mmap (basic) [54.340275] Starting subtest: basic [54.355519] Subtest basic: SUCCESS (0.000s) [54.401851] [036/162] (930s left) gem_mmap_gtt (basic) [54.452729] Starting subtest: basic [54.455812] Subtest basic: SUCCESS (0.001s) [54.498995] [037/162] (930s left) gem_render_linear_blits (basic) [54.547164] Starting subtest: basic [54.572828] Subtest basic: SUCCESS (0.025s) [54.629979] [038/162] (930s left) gem_render_tiled_blits (basic) [54.680604] Starting subtest: basic [54.708578] Subtest basic: SUCCESS (0.029s) [54.822279] [039/162] (930s left) gem_ringfill (basic-all) [55.056489] Starting subtest: basic-all [56.199259] Subtest basic-all: SUCCESS (1.140s) [56.281593] [040/162] (929s left) gem_softpin (allocator-basic) [56.337060] Starting subtest: allocator-basic [56.427162] Subtest allocator-basic: SUCCESS (0.094s) [56.505972] [041/162] (929s left) gem_softpin (allocator-basic-reserve) [56.558174] Starting subtest: allocator-basic-reserve [56.647867] Subtest allocator-basic-reserve: SUCCESS (0.091s) [56.726973] [042/162] (928s left) gem_softpin (safe-alignment) [56.781562] Starting subtest: safe-alignment [56.790784] Subtest safe-alignment: SUCCESS (0.010s) [56.864541] [043/162] (928s left) gem_sync (basic-all) [56.940560] Starting subtest: basic-all [58.938464] Subtest basic-all: SUCCESS (2.023s) [59.087449] [044/162] (926s left) gem_sync (basic-each) [59.164556] Starting subtest: basic-each [61.252825] Subtest basic-each: SUCCESS (2.111s) [61.405812] [045/162] (924s left) gem_tiled_blits (basic) [61.518112] Starting subtest: basic [61.530317] Subtest basic: SUCCESS (0.016s) [61.626511] [046/162] (924s left) gem_tiled_fence_blits (basic) [61.809366] Starting subtest: basic [61.816702] Subtest basic: SUCCESS (0.008s) [61.907503] [047/162] (923s left) gem_tiled_pread_basic (basic) [62.042154] Starting subtest: basic [62.152849] Subtest basic: SUCCESS (0.115s) [62.215849] [048/162] (923s left) gem_wait (busy@all-engines) [62.275346] Starting subtest: busy [62.278485] Starting dynamic subtest: all-engines [62.796471] Dynamic subtest all-engines: SUCCESS (0.522s) [62.799818] Subtest busy: SUCCESS (0.522s) [62.957501] [049/162] (923s left) gem_wait (wait@all-engines) [63.019188] Starting subtest: wait [63.022509] Starting dynamic subtest: all-engines [64.039202] Dynamic subtest all-engines: SUCCESS (1.024s) [64.042415] Subtest wait: SUCCESS (1.025s) [64.198415] [050/162] (921s left) i915_getparams_basic (basic-eu-total) [64.246932] Starting subtest: basic-eu-total [64.253527] Subtest basic-eu-total: SUCCESS (0.000s) [64.296940] [051/162] (921s left) i915_getparams_basic (basic-subslice-total) [64.345493] Starting subtest: basic-subslice-total [64.352109] Subtest basic-subslice-total: SUCCESS (0.000s) [64.395203] [052/162] (921s left) i915_hangman (error-state-basic) [64.452734] Starting subtest: error-state-basic [64.461274] Subtest error-state-basic: SUCCESS (0.006s) [64.543398] [053/162] (921s left) i915_pciid [64.642427] [054/162] (921s left) intel_hwmon (hwmon-read) [64.698645] Subtest hwmon-read: SKIP (0.000s) [64.740977] [055/162] (921s left) intel_hwmon (hwmon-write) [64.794185] Subtest hwmon-write: SKIP (0.000s) [64.837666] [056/162] (921s left) kms_addfb_basic (addfb25-4-tiled) [64.928641] Starting subtest: addfb25-4-tiled [64.932049] Subtest addfb25-4-tiled: SUCCESS (0.000s) [65.002838] [057/162] (921s left) kms_addfb_basic (addfb25-bad-modifier) [65.081234] Starting subtest: addfb25-bad-modifier [65.084517] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [65.139476] [058/162] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [65.225164] Starting subtest: addfb25-framebuffer-vs-set-tiling [65.228119] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [65.288425] [059/162] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [65.369137] Starting subtest: addfb25-modifier-no-flag [65.372179] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [65.426661] [060/162] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy) [65.506667] Starting subtest: addfb25-x-tiled-legacy [65.509673] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [65.565926] [061/162] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [65.648773] Starting subtest: addfb25-x-tiled-mismatch-legacy [65.651801] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [65.718791] [062/162] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [65.797498] Starting subtest: addfb25-yf-tiled-legacy [65.800510] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [65.869347] [063/162] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [65.949918] Starting subtest: addfb25-y-tiled-legacy [65.953168] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [66.014242] [064/162] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [66.097159] Starting subtest: addfb25-y-tiled-small-legacy [66.100338] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [66.160248] [065/162] (920s left) kms_addfb_basic (bad-pitch-0) [66.211895] Starting subtest: bad-pitch-0 [66.215320] Subtest bad-pitch-0: SUCCESS (0.000s) [66.298983] [066/162] (920s left) kms_addfb_basic (bad-pitch-1024) [66.353150] Starting subtest: bad-pitch-1024 [66.356377] Subtest bad-pitch-1024: SUCCESS (0.000s) [66.441763] [067/162] (920s left) kms_addfb_basic (bad-pitch-128) [66.494809] Starting subtest: bad-pitch-128 [66.499940] Subtest bad-pitch-128: SUCCESS (0.000s) [66.600856] [068/162] (920s left) kms_addfb_basic (bad-pitch-256) [66.655958] Starting subtest: bad-pitch-256 [66.660797] Subtest bad-pitch-256: SUCCESS (0.000s) [66.808093] [069/162] (920s left) kms_addfb_basic (bad-pitch-32) [66.890466] Starting subtest: bad-pitch-32 [66.894796] Subtest bad-pitch-32: SUCCESS (0.000s) [67.208435] [070/162] (919s left) kms_addfb_basic (bad-pitch-63) [67.282420] Starting subtest: bad-pitch-63 [67.287396] Subtest bad-pitch-63: SUCCESS (0.000s) [67.422410] [071/162] (919s left) kms_addfb_basic (bad-pitch-65536) [67.474968] Starting subtest: bad-pitch-65536 [67.479596] Subtest bad-pitch-65536: SUCCESS (0.000s) [67.605103] [072/162] (919s left) kms_addfb_basic (bad-pitch-999) [67.655602] Starting subtest: bad-pitch-999 [67.659524] Subtest bad-pitch-999: SUCCESS (0.000s) [67.751535] [073/162] (919s left) kms_addfb_basic (basic) [67.800981] Starting subtest: basic [67.804646] Subtest basic: SUCCESS (0.000s) [67.901515] [074/162] (919s left) kms_addfb_basic (basic-x-tiled-legacy) [67.954302] Starting subtest: basic-x-tiled-legacy [67.958130] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [68.054365] [075/162] (919s left) kms_addfb_basic (basic-y-tiled-legacy) [68.103745] Starting subtest: basic-y-tiled-legacy [68.107457] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [68.210600] [076/162] (919s left) kms_addfb_basic (bo-too-small) [68.289928] Starting subtest: bo-too-small [68.293197] Subtest bo-too-small: SUCCESS (0.000s) [68.356266] [077/162] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling) [68.435342] Starting subtest: bo-too-small-due-to-tiling [68.438424] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [68.486441] [078/162] (918s left) kms_addfb_basic (clobberred-modifier) [68.536564] Starting subtest: clobberred-modifier [68.539744] Subtest clobberred-modifier: SUCCESS (0.000s) [68.625919] [079/162] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling) [68.678109] Starting subtest: framebuffer-vs-set-tiling [68.682626] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [68.765370] [080/162] (918s left) kms_addfb_basic (invalid-get-prop) [68.816512] Starting subtest: invalid-get-prop [68.819969] Subtest invalid-get-prop: SUCCESS (0.000s) [68.907251] [081/162] (918s left) kms_addfb_basic (invalid-get-prop-any) [68.957594] Starting subtest: invalid-get-prop-any [68.961404] Subtest invalid-get-prop-any: SUCCESS (0.000s) [69.046482] [082/162] (918s left) kms_addfb_basic (invalid-set-prop) [69.094901] Starting subtest: invalid-set-prop [69.098891] Subtest invalid-set-prop: SUCCESS (0.000s) [69.196649] [083/162] (918s left) kms_addfb_basic (invalid-set-prop-any) [69.247700] Starting subtest: invalid-set-prop-any [69.252110] Subtest invalid-set-prop-any: SUCCESS (0.000s) [69.343522] [084/162] (918s left) kms_addfb_basic (no-handle) [69.397760] Starting subtest: no-handle [69.403298] Subtest no-handle: SUCCESS (0.000s) [69.487231] [085/162] (918s left) kms_addfb_basic (size-max) [69.567755] Starting subtest: size-max [69.571106] Subtest size-max: SUCCESS (0.000s) [69.625278] [086/162] (918s left) kms_addfb_basic (small-bo) [69.704122] Starting subtest: small-bo [69.707242] Subtest small-bo: SUCCESS (0.000s) [69.766481] [087/162] (917s left) kms_addfb_basic (tile-pitch-mismatch) [69.821570] Starting subtest: tile-pitch-mismatch [69.825961] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [69.910339] [088/162] (917s left) kms_addfb_basic (too-high) [69.989029] Starting subtest: too-high [69.992390] Subtest too-high: SUCCESS (0.001s) [70.052168] [089/162] (917s left) kms_addfb_basic (too-wide) [70.133419] Starting subtest: too-wide [70.136524] Subtest too-wide: SUCCESS (0.000s) [70.202397] [090/162] (917s left) kms_addfb_basic (unused-handle) [70.255657] Starting subtest: unused-handle [70.259128] Subtest unused-handle: SUCCESS (0.000s) [70.343725] [091/162] (917s left) kms_addfb_basic (unused-modifier) [70.393883] Starting subtest: unused-modifier [70.399222] Subtest unused-modifier: SUCCESS (0.000s) [70.489544] [092/162] (917s left) kms_addfb_basic (unused-offsets) [70.542669] Starting subtest: unused-offsets [70.546236] Subtest unused-offsets: SUCCESS (0.000s) [70.628344] [093/162] (917s left) kms_addfb_basic (unused-pitches) [70.678675] Starting subtest: unused-pitches [70.682624] Subtest unused-pitches: SUCCESS (0.000s) [70.767739] [094/162] (917s left) kms_busy (basic) [70.850468] Subtest basic: SKIP (0.000s) [70.895628] [095/162] (917s left) kms_prop_blob (basic) [70.945688] Starting subtest: basic [70.948830] Subtest basic: SUCCESS (0.000s) [70.991361] [096/162] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [71.093913] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [71.139128] [097/162] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [71.236972] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [71.282076] [098/162] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [71.381216] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [71.425930] [099/162] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [71.522079] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [71.567237] [100/162] (916s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [71.667206] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [71.711914] [101/162] (916s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [71.815399] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [71.861823] [102/162] (916s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [71.962699] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [72.155677] [103/162] (916s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [73.088089] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [73.516858] [104/162] (915s left) kms_dsc (dsc-basic) [73.603136] Subtest dsc-basic: SKIP (0.000s) [73.647134] [105/162] (915s left) kms_flip (basic-flip-vs-dpms) [73.725203] Starting subtest: basic-flip-vs-dpms [73.731302] Subtest basic-flip-vs-dpms: SKIP (0.001s) [73.795281] [106/162] (915s left) kms_flip (basic-flip-vs-modeset) [73.874611] Starting subtest: basic-flip-vs-modeset [73.880425] Subtest basic-flip-vs-modeset: SKIP (0.001s) [73.933117] [107/162] (915s left) kms_flip (basic-flip-vs-wf_vblank) [74.012312] Starting subtest: basic-flip-vs-wf_vblank [74.018776] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [74.062486] [108/162] (915s left) kms_flip (basic-plain-flip) [74.143381] Starting subtest: basic-plain-flip [74.149584] Subtest basic-plain-flip: SKIP (0.001s) [74.208890] [109/162] (915s left) kms_force_connector_basic (force-connector-state) [74.356796] Starting subtest: force-connector-state [74.441477] Subtest force-connector-state: SUCCESS (0.079s) [74.614827] [110/162] (914s left) kms_force_connector_basic (force-edid) [74.772011] Starting subtest: force-edid [74.972742] Subtest force-edid: SUCCESS (0.195s) [75.057515] [111/162] (914s left) kms_force_connector_basic (force-load-detect) [75.217010] Starting subtest: force-load-detect [75.223168] Subtest force-load-detect: SKIP (0.000s) [75.285321] [112/162] (914s left) kms_force_connector_basic (prune-stale-modes) [75.437669] Starting subtest: prune-stale-modes [75.625511] Subtest prune-stale-modes: SUCCESS (0.188s) [75.711457] [113/162] (913s left) kms_frontbuffer_tracking (basic) [75.796138] Subtest basic: SKIP (0.000s) [75.848945] [114/162] (913s left) kms_hdmi_inject (inject-audio) [75.901917] Starting subtest: inject-audio [75.918572] Subtest inject-audio: SKIP (0.000s) [75.963299] [115/162] (913s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [76.049263] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [76.101462] [116/162] (913s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [76.181732] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [76.225928] [117/162] (913s left) kms_pipe_crc_basic (hang-read-crc) [76.306339] Subtest hang-read-crc: SKIP (0.000s) [76.350246] [118/162] (913s left) kms_pipe_crc_basic (nonblocking-crc) [76.432607] Subtest nonblocking-crc: SKIP (0.000s) [76.481150] [119/162] (913s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [76.564848] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [76.608816] [120/162] (913s left) kms_pipe_crc_basic (read-crc) [76.696593] Subtest read-crc: SKIP (0.000s) [76.746466] [121/162] (913s left) kms_pipe_crc_basic (read-crc-frame-sequence) [76.827186] Subtest read-crc-frame-sequence: SKIP (0.000s) [76.871463] [122/162] (912s left) kms_pm_backlight (basic-brightness) [76.956532] Subtest basic-brightness: SKIP (0.000s) [77.001662] [123/162] (912s left) kms_pm_rpm (basic-pci-d3-state) [88.300726] Starting subtest: basic-pci-d3-state [88.485951] Subtest basic-pci-d3-state: SUCCESS (0.185s) [88.542237] [124/162] (901s left) kms_pm_rpm (basic-rte) [88.597059] Starting subtest: basic-rte [100.122883] Subtest basic-rte: SUCCESS (11.527s) [100.426753] [125/162] (889s left) kms_psr (psr-primary-page-flip) [100.505897] Subtest psr-primary-page-flip: SKIP (0.000s) [100.550522] [126/162] (889s left) kms_psr (psr-cursor-plane-move) [100.630544] Subtest psr-cursor-plane-move: SKIP (0.000s) [100.673944] [127/162] (889s left) kms_psr (psr-sprite-plane-onoff) [100.756711] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [100.800974] [128/162] (889s left) kms_psr (psr-primary-mmap-gtt) [100.880279] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [100.925508] [129/162] (889s left) kms_setmode (basic-clone-single-crtc) [100.978870] Starting subtest: basic-clone-single-crtc [100.988871] Subtest basic-clone-single-crtc: SKIP (0.000s) [101.036869] [130/162] (889s left) i915_pm_rps (basic-api) [101.088938] Starting subtest: basic-api [101.091941] Subtest basic-api: SUCCESS (0.003s) [101.141757] [131/162] (889s left) prime_self_import (basic-llseek-bad) [101.190327] Starting subtest: basic-llseek-bad [101.196526] Subtest basic-llseek-bad: SUCCESS (0.002s) [101.256896] [132/162] (889s left) prime_self_import (basic-llseek-size) [101.306139] Starting subtest: basic-llseek-size [101.312714] Subtest basic-llseek-size: SUCCESS (0.003s) [101.377908] [133/162] (888s left) prime_self_import (basic-with_fd_dup) [101.424783] Starting subtest: basic-with_fd_dup [101.431423] Subtest basic-with_fd_dup: SUCCESS (0.002s) [101.495857] [134/162] (888s left) prime_self_import (basic-with_one_bo) [101.539569] Starting subtest: basic-with_one_bo [101.545966] Subtest basic-with_one_bo: SUCCESS (0.003s) [101.589967] [135/162] (888s left) prime_self_import (basic-with_one_bo_two_files) [101.640532] Starting subtest: basic-with_one_bo_two_files [101.646787] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [101.716741] [136/162] (888s left) prime_self_import (basic-with_two_bos) [101.760438] Starting subtest: basic-with_two_bos [101.766798] Subtest basic-with_two_bos: SUCCESS (0.002s) [101.833774] [137/162] (888s left) prime_vgem (basic-fence-flip) [101.893436] Starting subtest: basic-fence-flip [101.926485] Subtest basic-fence-flip: SKIP (0.029s) [101.972688] [138/162] (888s left) prime_vgem (basic-fence-mmap) [102.024123] Starting subtest: basic-fence-mmap [102.044939] Subtest basic-fence-mmap: SUCCESS (0.023s) [102.119886] [139/162] (888s left) prime_vgem (basic-fence-read) [102.178333] Starting subtest: basic-fence-read [102.217863] Subtest basic-fence-read: SUCCESS (0.046s) [102.271203] [140/162] (888s left) prime_vgem (basic-gtt) [102.324564] Starting subtest: basic-gtt [102.335618] Subtest basic-gtt: SUCCESS (0.012s) [102.405190] [141/162] (888s left) prime_vgem (basic-read) [102.458122] Starting subtest: basic-read [102.480811] Subtest basic-read: SUCCESS (0.023s) [102.553287] [142/162] (888s left) prime_vgem (basic-write) [102.609602] Starting subtest: basic-write [102.626770] Subtest basic-write: SUCCESS (0.022s) [102.697763] [143/162] (888s left) vgem_basic (setversion) [102.751117] Starting subtest: setversion [102.757286] Subtest setversion: SUCCESS (0.000s) [102.805817] [144/162] (888s left) vgem_basic (create) [102.851455] Starting subtest: create [102.854431] Subtest create: SUCCESS (0.000s) [102.904735] [145/162] (888s left) vgem_basic (debugfs) [102.953763] Starting subtest: debugfs [102.957369] Subtest debugfs: SUCCESS (0.000s) [103.006896] [146/162] (887s left) vgem_basic (dmabuf-export) [103.054157] Starting subtest: dmabuf-export [103.060827] Subtest dmabuf-export: SUCCESS (0.002s) [103.123124] [147/162] (887s left) vgem_basic (dmabuf-fence) [103.173224] Starting subtest: dmabuf-fence [103.176289] Subtest dmabuf-fence: SUCCESS (0.001s) [103.220732] [148/162] (887s left) vgem_basic (dmabuf-fence-before) [103.273872] Starting subtest: dmabuf-fence-before [103.276963] Subtest dmabuf-fence-before: SUCCESS (0.000s) [103.324823] [149/162] (887s left) vgem_basic (dmabuf-mmap) [103.375198] Starting subtest: dmabuf-mmap [103.381415] Subtest dmabuf-mmap: SUCCESS (0.009s) [103.425152] [150/162] (887s left) vgem_basic (mmap) [103.478499] Starting subtest: mmap [103.481598] Subtest mmap: SUCCESS (0.007s) [103.526380] [151/162] (887s left) vgem_basic (second-client) [103.576745] Starting subtest: second-client [103.582950] Subtest second-client: SUCCESS (0.003s) [103.633393] [152/162] (887s left) vgem_basic (sysfs) [103.678733] Starting subtest: sysfs [103.681808] Subtest sysfs: SUCCESS (0.000s) [103.726366] [153/162] (887s left) core_hotunplug (unbind-rebind) [103.832618] Starting subtest: unbind-rebind [107.281230] Subtest unbind-rebind: SUCCESS (3.449s) [107.326455] [154/162] (884s left) vgem_basic (unload) [107.376353] Starting subtest: unload [136.220024] Subtest unload: SUCCESS (28.848s) [136.284486] [155/162] (855s left) i915_module_load (reload) [136.334591] Starting subtest: reload [138.802595] Subtest reload: SUCCESS (2.473s) [138.847263] [156/162] (852s left) gem_lmem_swapping (basic) [138.906219] Subtest basic: SKIP (0.000s) [138.951520] [157/162] (852s left) gem_lmem_swapping (parallel-random-engines) [139.007685] Subtest parallel-random-engines: SKIP (0.000s) [139.052796] [158/162] (852s left) gem_lmem_swapping (random-engines) [139.103395] Subtest random-engines: SKIP (0.000s) [139.146712] [159/162] (852s left) gem_lmem_swapping (verify-random) [139.200626] Subtest verify-random: SKIP (0.000s) [139.244357] [160/162] (852s left) i915_pm_rpm (module-reload) [150.538759] Starting subtest: module-reload [178.027762] Subtest module-reload: SUCCESS (27.489s) [178.058494] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [178.059488] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [178.064262] [161/162] (813s left) i915_selftest (live) [178.115051] Starting subtest: live [178.118176] Starting dynamic subtest: sanitycheck [180.167801] Dynamic subtest sanitycheck: SUCCESS (2.053s) [180.179154] Starting dynamic subtest: uncore [182.296522] Dynamic subtest uncore: SUCCESS (2.074s) [182.361334] Starting dynamic subtest: workarounds [184.531276] Dynamic subtest workarounds: SUCCESS (2.286s) [184.548362] Starting dynamic subtest: gt_engines [187.084808] Dynamic subtest gt_engines: SUCCESS (2.545s) [187.099082] Starting dynamic subtest: gt_timelines [195.826982] Dynamic subtest gt_timelines: SUCCESS (8.750s) [195.839106] Starting dynamic subtest: gt_contexts [198.001735] Dynamic subtest gt_contexts: SUCCESS (2.174s) [198.012825] Starting dynamic subtest: gt_lrc [202.589241] Dynamic subtest gt_lrc: SUCCESS (4.585s) [202.602228] Starting dynamic subtest: gt_mocs [204.835144] Dynamic subtest gt_mocs: SUCCESS (2.241s) [204.847026] Starting dynamic subtest: gt_pm [211.267432] Dynamic subtest gt_pm: SUCCESS (6.435s) [211.280341] Starting dynamic subtest: gt_heartbeat [213.335272] Dynamic subtest gt_heartbeat: SUCCESS (2.062s) [213.346723] Starting dynamic subtest: gt_tlb [216.605184] Dynamic subtest gt_tlb: SUCCESS (3.269s) [216.619196] Starting dynamic subtest: requests [224.965066] Dynamic subtest requests: SUCCESS (8.365s) [224.977126] Starting dynamic subtest: migrate [230.150298] Dynamic subtest migrate: SUCCESS (5.183s) [230.167250] Starting dynamic subtest: active [232.235466] Dynamic subtest active: SUCCESS (2.078s) [232.246630] Starting dynamic subtest: objects [234.905206] Dynamic subtest objects: SUCCESS (2.672s) [234.916935] Starting dynamic subtest: mman [240.121743] Dynamic subtest mman: SUCCESS (5.220s) [240.132882] Starting dynamic subtest: dmabuf [242.235704] Dynamic subtest dmabuf: SUCCESS (2.105s) [242.246950] Starting dynamic subtest: vma [244.295686] Dynamic subtest vma: SUCCESS (2.066s) [244.307205] Starting dynamic subtest: coherency [247.114413] Dynamic subtest coherency: SUCCESS (2.817s) [247.127233] Starting dynamic subtest: gtt [256.580390] Dynamic subtest gtt: SUCCESS (9.465s) [256.591946] Starting dynamic subtest: gem [258.865791] Dynamic subtest gem: SUCCESS (2.284s) [258.877376] Starting dynamic subtest: evict [262.184657] Dynamic subtest evict: SUCCESS (3.320s) [262.197335] Starting dynamic subtest: hugepages [270.786237] Dynamic subtest hugepages: SUCCESS (8.599s) [270.798208] Starting dynamic subtest: gem_contexts [285.495743] Dynamic subtest gem_contexts: SUCCESS (14.711s) [285.507604] Starting dynamic subtest: client [287.625234] Dynamic subtest client: SUCCESS (2.127s) [287.637163] Starting dynamic subtest: gem_migrate [289.694973] Dynamic subtest gem_migrate: SUCCESS (2.063s) [289.706366] Starting dynamic subtest: reset [291.964581] Dynamic subtest reset: SUCCESS (2.276s) [291.976198] Starting dynamic subtest: memory_region [294.054904] Dynamic subtest memory_region: SUCCESS (2.081s) [294.066951] Starting dynamic subtest: hangcheck [319.169697] Dynamic subtest hangcheck: SUCCESS (25.123s) [319.181726] Starting dynamic subtest: execlists [329.447915] Dynamic subtest execlists: SUCCESS (10.277s) [329.463754] Starting dynamic subtest: ring_submission [331.523807] Dynamic subtest ring_submission: SUCCESS (2.075s) [331.536106] Starting dynamic subtest: perf [333.734356] Dynamic subtest perf: SUCCESS (2.204s) [333.745777] Starting dynamic subtest: slpc [335.773306] Dynamic subtest slpc: SUCCESS (2.042s) [335.786177] Starting dynamic subtest: guc [337.864249] Dynamic subtest guc: SUCCESS (2.085s) [337.875916] Starting dynamic subtest: guc_multi_lrc [339.943994] Dynamic subtest guc_multi_lrc: SUCCESS (2.076s) [339.955375] Starting dynamic subtest: guc_hang [342.005234] Dynamic subtest guc_hang: SUCCESS (2.062s) [342.018299] Starting dynamic subtest: late_gt_pm [344.156092] Dynamic subtest late_gt_pm: SUCCESS (2.123s) [344.220024] Subtest live: SUCCESS (166.009s) [344.604572] [162/162] (647s left) dmabuf (all-tests) [344.997170] Starting subtest: all-tests [345.122109] Subtest all-tests: SKIP (0.000s) [345.158263] 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.