[37.932499] Initializing watchdogs [37.932613] /dev/watchdog0 [37.956780] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [37.965500] [001/162] (960s left) i915_module_load (load) [38.044309] Starting subtest: load [40.419625] Subtest load: SUCCESS (2.373s) [40.485881] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [40.488263] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [40.495275] [002/162] (958s left) core_auth (basic-auth) [40.630815] Starting subtest: basic-auth [40.634903] Subtest basic-auth: SUCCESS (0.002s) [40.730094] [003/162] (957s left) core_debugfs (read-all-entries) [40.797214] Starting subtest: read-all-entries [40.800723] Subtest read-all-entries: SUCCESS (0.004s) [40.851680] [004/162] (957s left) core_sysfs (read-all-entries) [40.925656] Starting subtest: read-all-entries [40.929518] Subtest read-all-entries: SUCCESS (0.005s) [40.980349] [005/162] (957s left) fbdev (eof) [41.055584] Subtest eof: SKIP (0.000s) [41.106116] [006/162] (957s left) fbdev (info) [41.184676] Subtest info: SKIP (0.000s) [41.234721] [007/162] (957s left) fbdev (nullptr) [41.308714] Subtest nullptr: SKIP (0.000s) [41.359182] [008/162] (957s left) fbdev (read) [41.437869] Subtest read: SKIP (0.000s) [41.491475] [009/162] (957s left) fbdev (write) [41.565050] Subtest write: SKIP (0.000s) [41.614829] [010/162] (957s left) gem_basic (bad-close) [41.681328] Starting subtest: bad-close [41.688474] Subtest bad-close: SUCCESS (0.000s) [41.741748] [011/162] (957s left) gem_basic (create-close) [41.804322] Starting subtest: create-close [41.811109] Subtest create-close: SUCCESS (0.000s) [41.870107] [012/162] (957s left) gem_basic (create-fd-close) [41.933617] Starting subtest: create-fd-close [41.940060] Subtest create-fd-close: SUCCESS (0.000s) [41.997387] [013/162] (957s left) gem_busy (busy@all-engines) [42.086388] Starting subtest: busy [42.089743] Starting dynamic subtest: all-engines [42.155750] Dynamic subtest all-engines: SUCCESS (0.073s) [42.159016] Subtest busy: SUCCESS (0.073s) [42.567906] [014/162] (956s left) gem_close_race (basic-process) [42.660272] Starting subtest: basic-process [42.733815] Subtest basic-process: SUCCESS (0.073s) [42.916463] [015/162] (956s left) gem_close_race (basic-threads) [43.001630] Starting subtest: basic-threads [44.257694] Subtest basic-threads: SUCCESS (1.247s) [44.449239] [016/162] (954s left) gem_ctx_create (basic) [44.537937] Starting subtest: basic [44.543341] Subtest basic: SUCCESS (0.000s) [44.730834] [017/162] (954s left) gem_ctx_create (basic-files) [44.816062] Starting subtest: basic-files [46.829738] Subtest basic-files: SUCCESS (2.016s) [47.109188] [018/162] (952s left) gem_ctx_exec (basic) [47.173837] Starting subtest: basic [47.181762] Subtest basic: SUCCESS (0.008s) [47.275488] [019/162] (952s left) gem_exec_basic (basic) [47.345985] Starting subtest: basic [47.347249] Starting dynamic subtest: rcs0-smem [47.349813] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [47.360195] Starting dynamic subtest: bcs0-smem [47.361495] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [47.370736] Starting dynamic subtest: vcs0-smem [47.372044] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [47.381138] Starting dynamic subtest: vcs1-smem [47.382339] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [47.391524] Starting dynamic subtest: vecs0-smem [47.392862] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [47.394164] Subtest basic: SUCCESS (0.009s) [47.594024] [020/162] (952s left) gem_exec_create (basic) [47.742372] Starting subtest: basic [47.743424] Starting dynamic subtest: smem [49.761171] Dynamic subtest smem: SUCCESS (2.045s) [49.762714] Subtest basic: SUCCESS (2.046s) [49.929612] [021/162] (949s left) gem_exec_fence (basic-busy) [50.158553] Starting subtest: basic-busy [50.160417] Starting dynamic subtest: rcs0 [50.194964] Dynamic subtest rcs0: SUCCESS (0.035s) [50.205828] Starting dynamic subtest: bcs0 [50.220658] Dynamic subtest bcs0: SUCCESS (0.025s) [50.230923] Starting dynamic subtest: vcs0 [50.243466] Dynamic subtest vcs0: SUCCESS (0.022s) [50.253910] Starting dynamic subtest: vcs1 [50.269548] Dynamic subtest vcs1: SUCCESS (0.025s) [50.279695] Starting dynamic subtest: vecs0 [50.292430] Dynamic subtest vecs0: SUCCESS (0.022s) [50.293788] Subtest basic-busy: SUCCESS (0.132s) [51.006677] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [51.009655] [022/162] (948s left) gem_exec_fence (basic-wait) [51.243189] Starting subtest: basic-wait [51.245507] Starting dynamic subtest: rcs0 [51.274655] Dynamic subtest rcs0: SUCCESS (0.033s) [51.289042] Starting dynamic subtest: bcs0 [51.303534] Dynamic subtest bcs0: SUCCESS (0.028s) [51.316159] Starting dynamic subtest: vcs0 [51.331657] Dynamic subtest vcs0: SUCCESS (0.027s) [51.344272] Starting dynamic subtest: vcs1 [51.360576] Dynamic subtest vcs1: SUCCESS (0.028s) [51.373248] Starting dynamic subtest: vecs0 [51.386646] Dynamic subtest vecs0: SUCCESS (0.025s) [51.388043] Subtest basic-wait: SUCCESS (0.144s) [52.055265] [023/162] (947s left) gem_exec_fence (basic-await) [52.287793] Starting subtest: basic-await [52.289684] Starting dynamic subtest: rcs0 [52.462668] Dynamic subtest rcs0: SUCCESS (0.115s) [52.473775] Starting dynamic subtest: bcs0 [52.511417] Dynamic subtest bcs0: SUCCESS (0.105s) [52.522353] Starting dynamic subtest: vcs0 [52.615560] Dynamic subtest vcs0: SUCCESS (0.102s) [52.626144] Starting dynamic subtest: vcs1 [52.720105] Dynamic subtest vcs1: SUCCESS (0.103s) [52.734556] Starting dynamic subtest: vecs0 [52.905997] Dynamic subtest vecs0: SUCCESS (0.126s) [52.908832] Subtest basic-await: SUCCESS (0.553s) [53.560776] [024/162] (946s left) gem_exec_fence (nb-await) [53.775449] Starting subtest: nb-await [53.777196] Starting dynamic subtest: rcs0 [53.846607] Dynamic subtest rcs0: SUCCESS (0.070s) [53.864780] Starting dynamic subtest: bcs0 [53.922413] Dynamic subtest bcs0: SUCCESS (0.073s) [53.955613] Starting dynamic subtest: vcs0 [54.011808] Dynamic subtest vcs0: SUCCESS (0.087s) [54.044955] Starting dynamic subtest: vcs1 [54.099630] Dynamic subtest vcs1: SUCCESS (0.085s) [54.128653] Starting dynamic subtest: vecs0 [54.180940] Dynamic subtest vecs0: SUCCESS (0.080s) [54.184003] Subtest nb-await: SUCCESS (0.401s) [54.852874] [025/162] (945s left) gem_exec_gttfill (basic) [54.939697] Starting subtest: basic [59.743641] Subtest basic: SUCCESS (4.767s) [59.998691] [026/162] (940s left) gem_exec_parallel (engines) [60.262677] Starting subtest: engines [60.263648] Starting dynamic subtest: basic [62.627334] Dynamic subtest basic: SUCCESS (2.379s) [62.638344] Starting dynamic subtest: contexts [70.241307] Dynamic subtest contexts: SUCCESS (7.638s) [70.255151] Starting dynamic subtest: fds [77.142638] Dynamic subtest fds: SUCCESS (6.843s) [77.157486] Starting dynamic subtest: userptr [79.453437] Dynamic subtest userptr: SUCCESS (2.312s) [79.455628] Subtest engines: SUCCESS (19.174s) [79.606145] [027/162] (920s left) gem_exec_store (basic) [79.684862] Starting subtest: basic [79.757780] Subtest basic: SUCCESS (0.073s) [79.954860] [028/162] (920s left) gem_flink_basic (bad-flink) [80.017080] Starting subtest: bad-flink [80.018190] Subtest bad-flink: SUCCESS (0.000s) [80.073211] [029/162] (920s left) gem_flink_basic (bad-open) [80.129884] Starting subtest: bad-open [80.131065] Subtest bad-open: SUCCESS (0.000s) [80.185406] [030/162] (920s left) gem_flink_basic (basic) [80.466192] Starting subtest: basic [80.468649] Subtest basic: SUCCESS (0.000s) [80.550485] [031/162] (919s left) gem_flink_basic (double-flink) [80.609425] Starting subtest: double-flink [80.610361] Subtest double-flink: SUCCESS (0.000s) [80.683875] [032/162] (919s left) gem_flink_basic (flink-lifetime) [80.740539] Starting subtest: flink-lifetime [80.741482] Subtest flink-lifetime: SUCCESS (0.002s) [80.814437] [033/162] (919s left) gem_huc_copy (huc-copy) [80.884234] Starting subtest: huc-copy [80.886122] Subtest huc-copy: SKIP (0.000s) [80.967939] [034/162] (919s left) gem_linear_blits (basic) [81.141278] Starting subtest: basic [81.154512] Subtest basic: SUCCESS (0.014s) [81.346344] [035/162] (919s left) gem_mmap (basic) [81.459188] Starting subtest: basic [81.463979] Subtest basic: SUCCESS (0.000s) [81.532607] [036/162] (919s left) gem_mmap_gtt (basic) [81.591497] Starting subtest: basic [81.592438] Subtest basic: SUCCESS (0.001s) [81.650782] [037/162] (919s left) gem_render_linear_blits (basic) [81.717897] Starting subtest: basic [81.751277] Subtest basic: SUCCESS (0.033s) [81.817285] [038/162] (919s left) gem_render_tiled_blits (basic) [81.885376] Starting subtest: basic [81.927497] Subtest basic: SUCCESS (0.042s) [81.995197] [039/162] (918s left) gem_ringfill (basic-all) [82.297844] Starting subtest: basic-all [83.531449] Subtest basic-all: SUCCESS (1.177s) [83.597959] [040/162] (917s left) gem_softpin (allocator-basic) [83.670193] Starting subtest: allocator-basic [83.868454] Subtest allocator-basic: SUCCESS (0.142s) [83.929499] [041/162] (917s left) gem_softpin (allocator-basic-reserve) [83.998016] Starting subtest: allocator-basic-reserve [84.200984] Subtest allocator-basic-reserve: SUCCESS (0.147s) [84.263233] [042/162] (916s left) gem_softpin (safe-alignment) [84.337182] Starting subtest: safe-alignment [84.355738] Subtest safe-alignment: SUCCESS (0.018s) [84.446549] [043/162] (916s left) gem_sync (basic-all) [84.527499] Starting subtest: basic-all [86.844602] Subtest basic-all: SUCCESS (2.285s) [87.025238] [044/162] (914s left) gem_sync (basic-each) [87.105522] Starting subtest: basic-each [89.348755] Subtest basic-each: SUCCESS (2.243s) [89.605195] [045/162] (911s left) gem_tiled_blits (basic) [89.745863] Starting subtest: basic [89.763267] Subtest basic: SUCCESS (0.017s) [89.893909] [046/162] (911s left) gem_tiled_fence_blits (basic) [90.478529] Starting subtest: basic [90.488609] Subtest basic: SUCCESS (0.011s) [90.588409] [047/162] (911s left) gem_tiled_pread_basic [90.935132] [048/162] (910s left) gem_wait (busy@all-engines) [91.027693] Starting subtest: busy [91.028792] Starting dynamic subtest: all-engines [91.610576] Dynamic subtest all-engines: SUCCESS (0.582s) [91.612620] Subtest busy: SUCCESS (0.583s) [91.898426] [049/162] (909s left) gem_wait (wait@all-engines) [91.982935] Starting subtest: wait [91.984175] Starting dynamic subtest: all-engines [93.073607] Dynamic subtest all-engines: SUCCESS (1.042s) [93.075948] Subtest wait: SUCCESS (1.044s) [93.263839] [050/162] (908s left) i915_getparams_basic (basic-eu-total) [93.327709] Starting subtest: basic-eu-total [93.329823] Subtest basic-eu-total: SUCCESS (0.000s) [93.384992] [051/162] (908s left) i915_getparams_basic (basic-subslice-total) [93.441565] Starting subtest: basic-subslice-total [93.443738] Subtest basic-subslice-total: SUCCESS (0.000s) [93.498250] [052/162] (908s left) i915_hangman (error-state-basic) [93.586555] Starting subtest: error-state-basic [93.595121] Subtest error-state-basic: SUCCESS (0.009s) [93.816293] [053/162] (908s left) i915_pciid [94.049429] [054/162] (908s left) intel_hwmon (hwmon-read) [94.107578] Subtest hwmon-read: SKIP (0.000s) [94.163910] [055/162] (907s left) intel_hwmon (hwmon-write) [94.219267] Subtest hwmon-write: SKIP (0.000s) [94.275291] [056/162] (907s left) kms_addfb_basic (addfb25-4-tiled) [94.552578] Starting subtest: addfb25-4-tiled [94.553920] Subtest addfb25-4-tiled: SUCCESS (0.001s) [94.648473] [057/162] (907s left) kms_addfb_basic (addfb25-bad-modifier) [94.927603] Starting subtest: addfb25-bad-modifier [94.928871] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [95.040299] [058/162] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.314444] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.315489] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.393514] [059/162] (907s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.658820] Starting subtest: addfb25-modifier-no-flag [95.660201] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [95.746610] [060/162] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.030891] Starting subtest: addfb25-x-tiled-legacy [96.034054] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.147090] [061/162] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.422104] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.423484] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [96.508131] [062/162] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [96.778508] Starting subtest: addfb25-yf-tiled-legacy [96.780665] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.971864] [063/162] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy) [97.253872] Starting subtest: addfb25-y-tiled-legacy [97.255337] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [97.463987] [064/162] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.762555] Starting subtest: addfb25-y-tiled-small-legacy [97.763719] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [97.844941] [065/162] (905s left) kms_addfb_basic (bad-pitch-0) [97.904217] Starting subtest: bad-pitch-0 [97.905335] Subtest bad-pitch-0: SUCCESS (0.000s) [98.188293] [066/162] (904s left) kms_addfb_basic (bad-pitch-1024) [98.338736] Starting subtest: bad-pitch-1024 [98.340788] Subtest bad-pitch-1024: SUCCESS (0.000s) [98.662740] [067/162] (904s left) kms_addfb_basic (bad-pitch-128) [98.721743] Starting subtest: bad-pitch-128 [98.723200] Subtest bad-pitch-128: SUCCESS (0.000s) [99.028179] [068/162] (904s left) kms_addfb_basic (bad-pitch-256) [99.085561] Starting subtest: bad-pitch-256 [99.086550] Subtest bad-pitch-256: SUCCESS (0.000s) [99.386558] [069/162] (903s left) kms_addfb_basic (bad-pitch-32) [99.443959] Starting subtest: bad-pitch-32 [99.445134] Subtest bad-pitch-32: SUCCESS (0.000s) [99.740462] [070/162] (903s left) kms_addfb_basic (bad-pitch-63) [99.797148] Starting subtest: bad-pitch-63 [99.798170] Subtest bad-pitch-63: SUCCESS (0.000s) [100.109638] [071/162] (903s left) kms_addfb_basic (bad-pitch-65536) [100.167178] Starting subtest: bad-pitch-65536 [100.168211] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.470492] [072/162] (903s left) kms_addfb_basic (bad-pitch-999) [100.527315] Starting subtest: bad-pitch-999 [100.528237] Subtest bad-pitch-999: SUCCESS (0.000s) [100.836788] [073/162] (902s left) kms_addfb_basic (basic) [100.894582] Starting subtest: basic [100.895588] Subtest basic: SUCCESS (0.000s) [101.204506] [074/162] (902s left) kms_addfb_basic (basic-x-tiled-legacy) [101.264872] Starting subtest: basic-x-tiled-legacy [101.265909] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.569694] [075/162] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [101.629345] Starting subtest: basic-y-tiled-legacy [101.630400] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [101.928812] [076/162] (901s left) kms_addfb_basic (bo-too-small) [102.212168] Starting subtest: bo-too-small [102.213347] Subtest bo-too-small: SUCCESS (0.001s) [102.301464] [077/162] (901s left) kms_addfb_basic (bo-too-small-due-to-tiling) [102.582841] Starting subtest: bo-too-small-due-to-tiling [102.584918] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [102.673442] [078/162] (901s left) kms_addfb_basic (clobberred-modifier) [102.731448] Starting subtest: clobberred-modifier [102.732416] Subtest clobberred-modifier: SUCCESS (0.000s) [103.030460] [079/162] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling) [103.089763] Starting subtest: framebuffer-vs-set-tiling [103.090867] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [103.387296] [080/162] (900s left) kms_addfb_basic (invalid-get-prop) [103.446263] Starting subtest: invalid-get-prop [103.447228] Subtest invalid-get-prop: SUCCESS (0.000s) [103.748946] [081/162] (900s left) kms_addfb_basic (invalid-get-prop-any) [103.807897] Starting subtest: invalid-get-prop-any [103.808939] Subtest invalid-get-prop-any: SUCCESS (0.000s) [104.115124] [082/162] (900s left) kms_addfb_basic (invalid-set-prop) [104.172510] Starting subtest: invalid-set-prop [104.173532] Subtest invalid-set-prop: SUCCESS (0.000s) [104.487535] [083/162] (899s left) kms_addfb_basic (invalid-set-prop-any) [104.548209] Starting subtest: invalid-set-prop-any [104.549192] Subtest invalid-set-prop-any: SUCCESS (0.000s) [104.847064] [084/162] (899s left) kms_addfb_basic (no-handle) [104.904130] Starting subtest: no-handle [104.905185] Subtest no-handle: SUCCESS (0.000s) [105.207816] [085/162] (899s left) kms_addfb_basic (size-max) [105.481869] Starting subtest: size-max [105.483229] Subtest size-max: SUCCESS (0.000s) [105.559819] [086/162] (898s left) kms_addfb_basic (small-bo) [105.842280] Starting subtest: small-bo [105.844093] Subtest small-bo: SUCCESS (0.000s) [105.924503] [087/162] (898s left) kms_addfb_basic (tile-pitch-mismatch) [105.983274] Starting subtest: tile-pitch-mismatch [105.984249] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.284055] [088/162] (898s left) kms_addfb_basic (too-high) [106.551608] Starting subtest: too-high [106.556563] Subtest too-high: SUCCESS (0.003s) [106.642718] [089/162] (898s left) kms_addfb_basic (too-wide) [106.924426] Starting subtest: too-wide [106.925814] Subtest too-wide: SUCCESS (0.000s) [107.013971] [090/162] (897s left) kms_addfb_basic (unused-handle) [107.093377] Starting subtest: unused-handle [107.094488] Subtest unused-handle: SUCCESS (0.000s) [107.366152] [091/162] (897s left) kms_addfb_basic (unused-modifier) [107.426087] Starting subtest: unused-modifier [107.427017] Subtest unused-modifier: SUCCESS (0.000s) [107.747415] [092/162] (897s left) kms_addfb_basic (unused-offsets) [107.805278] Starting subtest: unused-offsets [107.806273] Subtest unused-offsets: SUCCESS (0.000s) [108.105115] [093/162] (896s left) kms_addfb_basic (unused-pitches) [108.162250] Starting subtest: unused-pitches [108.163165] Subtest unused-pitches: SUCCESS (0.000s) [108.459060] [094/162] (896s left) kms_busy (basic) [108.747865] Subtest basic: SKIP (0.000s) [108.809906] [095/162] (896s left) kms_prop_blob (basic) [108.867398] Starting subtest: basic [108.868346] Subtest basic: SUCCESS (0.000s) [108.925814] [096/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [109.201448] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [109.259168] [097/162] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [109.542694] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [109.604160] [098/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [109.882842] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [109.938742] [099/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [110.219349] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [110.279987] [100/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [110.553860] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [110.616641] [101/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [110.896025] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [110.954988] [102/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [111.234833] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [111.295761] [103/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [111.583259] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [111.644338] [104/162] (893s left) kms_dsc (dsc-basic) [111.910989] Subtest dsc-basic: SKIP (0.000s) [111.974846] [105/162] (893s left) kms_flip (basic-flip-vs-dpms) [112.250827] Starting subtest: basic-flip-vs-dpms [112.254724] Subtest basic-flip-vs-dpms: SKIP (0.003s) [112.332581] [106/162] (893s left) kms_flip (basic-flip-vs-modeset) [112.613343] Starting subtest: basic-flip-vs-modeset [112.621523] Subtest basic-flip-vs-modeset: SKIP (0.006s) [112.695948] [107/162] (893s left) kms_flip (basic-flip-vs-wf_vblank) [112.970998] Starting subtest: basic-flip-vs-wf_vblank [112.976222] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [113.058123] [108/162] (892s left) kms_flip (basic-plain-flip) [113.334348] Starting subtest: basic-plain-flip [113.338299] Subtest basic-plain-flip: SKIP (0.004s) [113.415786] [109/162] (892s left) kms_force_connector_basic (force-connector-state) [113.806737] Starting subtest: force-connector-state [114.594990] Subtest force-connector-state: SUCCESS (0.787s) [115.212828] [110/162] (890s left) kms_force_connector_basic (force-edid) [115.606844] Starting subtest: force-edid [116.254461] Subtest force-edid: SUCCESS (0.648s) [116.756901] [111/162] (889s left) kms_force_connector_basic (force-load-detect) [117.144636] Starting subtest: force-load-detect [117.147975] Subtest force-load-detect: SKIP (0.000s) [117.529908] [112/162] (888s left) kms_force_connector_basic (prune-stale-modes) [117.916382] Starting subtest: prune-stale-modes [118.645077] Subtest prune-stale-modes: SUCCESS (0.730s) [119.151541] [113/162] (887s left) kms_frontbuffer_tracking (basic) [119.427849] Subtest basic: SKIP (0.000s) [119.504226] [114/162] (886s left) kms_hdmi_inject (inject-audio) [119.564119] Starting subtest: inject-audio [120.193807] Subtest inject-audio: SUCCESS (0.627s) [120.507224] [115/162] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [120.796121] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [120.864829] [116/162] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [121.138630] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [121.213576] [117/162] (885s left) kms_pipe_crc_basic (hang-read-crc) [121.478283] Subtest hang-read-crc: SKIP (0.000s) [121.544286] [118/162] (884s left) kms_pipe_crc_basic (nonblocking-crc) [121.814922] Subtest nonblocking-crc: SKIP (0.000s) [121.880132] [119/162] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.169530] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [122.229484] [120/162] (884s left) kms_pipe_crc_basic (read-crc) [122.514452] Subtest read-crc: SKIP (0.000s) [122.580123] [121/162] (884s left) kms_pipe_crc_basic (read-crc-frame-sequence) [122.847315] Subtest read-crc-frame-sequence: SKIP (0.000s) [122.914757] [122/162] (883s left) kms_pm_backlight (basic-brightness) [123.193872] Subtest basic-brightness: SKIP (0.000s) [123.265345] [123/162] (883s left) kms_pm_rpm (basic-pci-d3-state) [124.909136] Starting subtest: basic-pci-d3-state [125.226566] Subtest basic-pci-d3-state: SUCCESS (0.317s) [125.413052] [124/162] (881s left) kms_pm_rpm (basic-rte) [125.645908] Starting subtest: basic-rte [127.550237] Subtest basic-rte: SUCCESS (1.903s) [128.047807] [125/162] (878s left) kms_psr (psr-primary-page-flip) [128.486976] Subtest psr-primary-page-flip: SKIP (0.000s) [128.558633] [126/162] (878s left) kms_psr (psr-cursor-plane-move) [128.831862] Subtest psr-cursor-plane-move: SKIP (0.000s) [128.906685] [127/162] (878s left) kms_psr (psr-sprite-plane-onoff) [129.183255] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [129.255042] [128/162] (877s left) kms_psr (psr-primary-mmap-gtt) [129.526401] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [129.612208] [129/162] (877s left) kms_setmode (basic-clone-single-crtc) [129.671676] Starting subtest: basic-clone-single-crtc [129.676444] Subtest basic-clone-single-crtc: SKIP (0.000s) [129.733680] [130/162] (877s left) i915_pm_rps (basic-api) [129.805083] Starting subtest: basic-api [129.809535] Subtest basic-api: SUCCESS (0.005s) [129.887457] [131/162] (877s left) prime_self_import (basic-llseek-bad) [129.945722] Starting subtest: basic-llseek-bad [129.949934] Subtest basic-llseek-bad: SUCCESS (0.003s) [130.026821] [132/162] (877s left) prime_self_import (basic-llseek-size) [130.083025] Starting subtest: basic-llseek-size [130.087034] Subtest basic-llseek-size: SUCCESS (0.005s) [130.169802] [133/162] (877s left) prime_self_import (basic-with_fd_dup) [130.223950] Starting subtest: basic-with_fd_dup [130.227587] Subtest basic-with_fd_dup: SUCCESS (0.005s) [130.304182] [134/162] (877s left) prime_self_import (basic-with_one_bo) [130.359689] Starting subtest: basic-with_one_bo [130.364368] Subtest basic-with_one_bo: SUCCESS (0.004s) [130.428033] [135/162] (877s left) prime_self_import (basic-with_one_bo_two_files) [130.481621] Starting subtest: basic-with_one_bo_two_files [130.486354] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [130.572461] [136/162] (877s left) prime_self_import (basic-with_two_bos) [130.629147] Starting subtest: basic-with_two_bos [130.631148] Subtest basic-with_two_bos: SUCCESS (0.004s) [130.714473] [137/162] (877s left) prime_vgem (basic-fence-flip) [130.783087] Starting subtest: basic-fence-flip [131.002446] Subtest basic-fence-flip: SKIP (0.217s) [131.074787] [138/162] (876s left) prime_vgem (basic-fence-mmap) [131.141700] Starting subtest: basic-fence-mmap [131.173569] Subtest basic-fence-mmap: SUCCESS (0.032s) [131.251175] [139/162] (876s left) prime_vgem (basic-fence-read) [131.334395] Starting subtest: basic-fence-read [131.404282] Subtest basic-fence-read: SUCCESS (0.070s) [131.489047] [140/162] (876s left) prime_vgem (basic-gtt) [131.561409] Starting subtest: basic-gtt [131.575199] Subtest basic-gtt: SUCCESS (0.015s) [131.660055] [141/162] (876s left) prime_vgem (basic-read) [131.727345] Starting subtest: basic-read [131.761363] Subtest basic-read: SUCCESS (0.034s) [131.852562] [142/162] (876s left) prime_vgem (basic-write) [131.920206] Starting subtest: basic-write [131.955313] Subtest basic-write: SUCCESS (0.036s) [132.020608] [143/162] (876s left) vgem_basic (setversion) [132.080943] Starting subtest: setversion [132.083309] Subtest setversion: SUCCESS (0.000s) [132.141898] [144/162] (876s left) vgem_basic (create) [132.201200] Starting subtest: create [132.202210] Subtest create: SUCCESS (0.000s) [132.259202] [145/162] (875s left) vgem_basic (debugfs) [132.318334] Starting subtest: debugfs [132.319285] Subtest debugfs: SUCCESS (0.001s) [132.382373] [146/162] (875s left) vgem_basic (dmabuf-export) [132.441978] Starting subtest: dmabuf-export [132.454267] Subtest dmabuf-export: SUCCESS (0.013s) [132.531995] [147/162] (875s left) vgem_basic (dmabuf-fence) [132.591434] Starting subtest: dmabuf-fence [132.592421] Subtest dmabuf-fence: SUCCESS (0.001s) [132.650517] [148/162] (875s left) vgem_basic (dmabuf-fence-before) [132.710112] Starting subtest: dmabuf-fence-before [132.711100] Subtest dmabuf-fence-before: SUCCESS (0.000s) [132.771256] [149/162] (875s left) vgem_basic (dmabuf-mmap) [132.830379] Starting subtest: dmabuf-mmap [132.843189] Subtest dmabuf-mmap: SUCCESS (0.013s) [132.902016] [150/162] (875s left) vgem_basic (mmap) [132.961885] Starting subtest: mmap [132.969641] Subtest mmap: SUCCESS (0.010s) [133.030147] [151/162] (875s left) vgem_basic (second-client) [133.089462] Starting subtest: second-client [133.092836] Subtest second-client: SUCCESS (0.004s) [133.150852] [152/162] (875s left) vgem_basic (sysfs) [133.210061] Starting subtest: sysfs [133.211111] Subtest sysfs: SUCCESS (0.001s) [133.269179] [153/162] (875s left) core_hotunplug (unbind-rebind) [133.380328] Starting subtest: unbind-rebind [137.600730] Subtest unbind-rebind: SUCCESS (4.216s) [137.655686] [154/162] (871s left) vgem_basic (unload) [137.717508] Starting subtest: unload [166.785027] Subtest unload: SUCCESS (29.011s) [166.840437] [155/162] (841s left) i915_module_load (reload) [166.899038] Starting subtest: reload [170.466175] Subtest reload: SUCCESS (3.567s) [170.550952] [156/162] (838s left) gem_lmem_swapping (basic) [170.716049] Subtest basic: SKIP (0.000s) [170.782245] [157/162] (838s left) gem_lmem_swapping (parallel-random-engines) [170.846495] Subtest parallel-random-engines: SKIP (0.000s) [170.902246] [158/162] (838s left) gem_lmem_swapping (random-engines) [170.965422] Subtest random-engines: SKIP (0.000s) [171.021044] [159/162] (838s left) gem_lmem_swapping (verify-random) [171.086380] Subtest verify-random: SKIP (0.000s) [171.141920] [160/162] (837s left) i915_pm_rpm (module-reload) [174.238871] Starting subtest: module-reload [188.958264] Subtest module-reload: SUCCESS (14.667s) [189.017090] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [189.018848] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [189.021438] [161/162] (820s left) i915_selftest (live) [189.095183] Starting subtest: live [189.097264] Starting dynamic subtest: sanitycheck [191.833760] Dynamic subtest sanitycheck: SUCCESS (2.685s) [191.847028] Starting dynamic subtest: uncore [194.543129] Dynamic subtest uncore: SUCCESS (2.708s) [194.553578] Starting dynamic subtest: workarounds [197.639901] Dynamic subtest workarounds: SUCCESS (3.095s) [197.653155] Starting dynamic subtest: gt_engines [200.885399] Dynamic subtest gt_engines: SUCCESS (3.244s) [200.895810] Starting dynamic subtest: gt_timelines [215.341114] Dynamic subtest gt_timelines: SUCCESS (14.454s) [215.353547] Starting dynamic subtest: gt_contexts [218.256144] Dynamic subtest gt_contexts: SUCCESS (2.913s) [218.269350] Starting dynamic subtest: gt_lrc [224.145345] Dynamic subtest gt_lrc: SUCCESS (5.887s) [224.158234] Starting dynamic subtest: gt_mocs [226.963017] Dynamic subtest gt_mocs: SUCCESS (2.816s) [226.973460] Starting dynamic subtest: gt_pm [238.330906] Dynamic subtest gt_pm: SUCCESS (11.366s) [238.341325] Starting dynamic subtest: gt_heartbeat [241.068754] Dynamic subtest gt_heartbeat: SUCCESS (2.737s) [241.079138] Starting dynamic subtest: gt_tlb [245.397903] Dynamic subtest gt_tlb: SUCCESS (4.328s) [245.408503] Starting dynamic subtest: requests [255.557065] Dynamic subtest requests: SUCCESS (10.158s) [255.567598] Starting dynamic subtest: migrate [261.259888] Dynamic subtest migrate: SUCCESS (5.701s) [261.270385] Starting dynamic subtest: active [263.971008] Dynamic subtest active: SUCCESS (2.709s) [263.981483] Starting dynamic subtest: objects [267.614022] Dynamic subtest objects: SUCCESS (3.641s) [267.626991] Starting dynamic subtest: mman [273.988427] Dynamic subtest mman: SUCCESS (6.372s) [274.001301] Starting dynamic subtest: dmabuf [276.687204] Dynamic subtest dmabuf: SUCCESS (2.697s) [276.697727] Starting dynamic subtest: vma [279.421395] Dynamic subtest vma: SUCCESS (2.732s) [279.432029] Starting dynamic subtest: coherency [283.285632] Dynamic subtest coherency: SUCCESS (3.862s) [283.298082] Starting dynamic subtest: gtt [293.350407] Dynamic subtest gtt: SUCCESS (10.062s) [293.361052] Starting dynamic subtest: gem [296.558286] Dynamic subtest gem: SUCCESS (3.206s) [296.571641] Starting dynamic subtest: evict [301.469274] Dynamic subtest evict: SUCCESS (4.909s) [301.482633] Starting dynamic subtest: hugepages [310.694171] Dynamic subtest hugepages: SUCCESS (9.223s) [310.707038] Starting dynamic subtest: gem_contexts [330.573956] Dynamic subtest gem_contexts: SUCCESS (19.878s) [330.584669] Starting dynamic subtest: client [333.373455] Dynamic subtest client: SUCCESS (2.797s) [333.386707] Starting dynamic subtest: gem_migrate [336.107988] Dynamic subtest gem_migrate: SUCCESS (2.733s) [336.118455] Starting dynamic subtest: reset [339.251819] Dynamic subtest reset: SUCCESS (3.142s) [339.262323] Starting dynamic subtest: memory_region [341.926066] Dynamic subtest memory_region: SUCCESS (2.671s) [341.936610] Starting dynamic subtest: hangcheck [373.368595] Dynamic subtest hangcheck: SUCCESS (31.436s) [373.378863] Starting dynamic subtest: execlists [389.244674] Dynamic subtest execlists: SUCCESS (15.878s) [389.257181] Starting dynamic subtest: ring_submission [391.953029] Dynamic subtest ring_submission: SUCCESS (2.706s) [391.963644] Starting dynamic subtest: perf [394.697100] Dynamic subtest perf: SUCCESS (2.741s) [394.707637] Starting dynamic subtest: slpc [397.387183] Dynamic subtest slpc: SUCCESS (2.688s) [397.397808] Starting dynamic subtest: guc [400.093842] Dynamic subtest guc: SUCCESS (2.705s) [400.104425] Starting dynamic subtest: guc_multi_lrc [402.796073] Dynamic subtest guc_multi_lrc: SUCCESS (2.700s) [402.806615] Starting dynamic subtest: guc_hang [405.513956] Dynamic subtest guc_hang: SUCCESS (2.715s) [405.524482] Starting dynamic subtest: late_gt_pm [408.246179] Dynamic subtest late_gt_pm: SUCCESS (2.730s) [408.248659] Subtest live: SUCCESS (219.094s) [408.315639] [162/162] (600s left) dmabuf (all-tests) [408.385776] Starting subtest: all-tests [408.387146] Starting dynamic subtest: sanitycheck [408.471184] Dynamic subtest sanitycheck: SUCCESS (0.075s) [408.503722] Starting dynamic subtest: dma_fence [408.680459] Dynamic subtest dma_fence: SUCCESS (0.213s) [408.709273] Starting dynamic subtest: dma_fence_chain [408.712457] Dynamic subtest dma_fence_chain: SKIP (0.001s) [408.741734] Starting dynamic subtest: dma_fence_unwrap [408.768042] Dynamic subtest dma_fence_unwrap: SUCCESS (0.078s) [408.792646] Starting dynamic subtest: dma_resv [408.855636] Dynamic subtest dma_resv: SUCCESS (0.083s) [408.858552] Subtest all-tests: SUCCESS (0.472s) [408.936236] 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.