[41.842577] Initializing watchdogs [41.842718] /dev/watchdog0 [41.873767] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [41.880145] [001/162] (960s left) i915_module_load (load) [41.944543] Starting subtest: load [44.506042] Subtest load: SUCCESS (2.557s) [44.551421] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [44.553297] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [44.557475] [002/162] (957s left) core_auth (basic-auth) [44.673675] Starting subtest: basic-auth [44.674858] Subtest basic-auth: SUCCESS (0.001s) [44.758244] [003/162] (957s left) core_debugfs (read-all-entries) [44.814674] Starting subtest: read-all-entries [44.817279] Subtest read-all-entries: SUCCESS (0.003s) [44.865283] [004/162] (957s left) core_sysfs (read-all-entries) [44.921505] Starting subtest: read-all-entries [44.926150] Subtest read-all-entries: SUCCESS (0.005s) [44.974102] [005/162] (957s left) fbdev (eof) [45.043390] Subtest eof: SKIP (0.000s) [45.088543] [006/162] (957s left) fbdev (info) [45.155899] Subtest info: SKIP (0.000s) [45.201650] [007/162] (957s left) fbdev (nullptr) [45.269669] Subtest nullptr: SKIP (0.000s) [45.315767] [008/162] (957s left) fbdev (read) [45.382138] Subtest read: SKIP (0.000s) [45.426200] [009/162] (957s left) fbdev (write) [45.492058] Subtest write: SKIP (0.000s) [45.548087] [010/162] (957s left) gem_basic (bad-close) [45.610377] Starting subtest: bad-close [45.612202] Subtest bad-close: SUCCESS (0.000s) [45.659661] [011/162] (957s left) gem_basic (create-close) [45.716954] Starting subtest: create-close [45.718988] Subtest create-close: SUCCESS (0.000s) [45.785248] [012/162] (957s left) gem_basic (create-fd-close) [45.841051] Starting subtest: create-fd-close [45.842981] Subtest create-fd-close: SUCCESS (0.000s) [45.908053] [013/162] (957s left) gem_busy (busy@all-engines) [45.985747] Starting subtest: busy [45.986782] Starting dynamic subtest: all-engines [46.040039] Dynamic subtest all-engines: SUCCESS (0.054s) [46.041467] Subtest busy: SUCCESS (0.055s) [46.409770] [014/162] (956s left) gem_close_race (basic-process) [46.488339] Starting subtest: basic-process [46.555385] Subtest basic-process: SUCCESS (0.068s) [46.749576] [015/162] (956s left) gem_close_race (basic-threads) [46.824744] Starting subtest: basic-threads [48.065907] Subtest basic-threads: SUCCESS (1.241s) [48.274119] [016/162] (954s left) gem_ctx_create (basic) [48.348534] Starting subtest: basic [48.349507] Subtest basic: SUCCESS (0.000s) [48.522896] [017/162] (954s left) gem_ctx_create (basic-files) [48.593573] Starting subtest: basic-files [50.612878] Subtest basic-files: SUCCESS (2.019s) [50.823058] [018/162] (952s left) gem_ctx_exec (basic) [50.887742] Starting subtest: basic [50.893509] Subtest basic: SUCCESS (0.006s) [50.996540] [019/162] (952s left) gem_exec_basic (basic) [51.063542] Starting subtest: basic [51.064840] Starting dynamic subtest: rcs0-smem [51.067084] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [51.079524] Starting dynamic subtest: bcs0-smem [51.081162] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [51.090781] Starting dynamic subtest: vcs0-smem [51.092354] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [51.101706] Starting dynamic subtest: vcs1-smem [51.102784] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [51.111942] Starting dynamic subtest: vecs0-smem [51.113019] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [51.114083] Subtest basic: SUCCESS (0.009s) [51.295694] [020/162] (952s left) gem_exec_create (basic) [51.369293] Starting subtest: basic [51.370212] Starting dynamic subtest: smem [53.426462] Dynamic subtest smem: SUCCESS (2.058s) [53.427441] Subtest basic: SUCCESS (2.059s) [53.601938] [021/162] (949s left) gem_exec_fence (basic-busy) [53.805241] Starting subtest: basic-busy [53.807096] Starting dynamic subtest: rcs0 [53.843728] Dynamic subtest rcs0: SUCCESS (0.038s) [53.864781] Starting dynamic subtest: bcs0 [53.872213] Dynamic subtest bcs0: SUCCESS (0.028s) [53.884176] Starting dynamic subtest: vcs0 [53.901231] Dynamic subtest vcs0: SUCCESS (0.028s) [53.911126] Starting dynamic subtest: vcs1 [53.925216] Dynamic subtest vcs1: SUCCESS (0.024s) [53.934646] Starting dynamic subtest: vecs0 [53.953261] Dynamic subtest vecs0: SUCCESS (0.028s) [53.954463] Subtest basic-busy: SUCCESS (0.149s) [54.627647] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [54.631274] [022/162] (948s left) gem_exec_fence (basic-wait) [54.833314] Starting subtest: basic-wait [54.834650] Starting dynamic subtest: rcs0 [54.863699] Dynamic subtest rcs0: SUCCESS (0.032s) [54.880295] Starting dynamic subtest: bcs0 [54.893349] Dynamic subtest bcs0: SUCCESS (0.029s) [54.907490] Starting dynamic subtest: vcs0 [54.923046] Dynamic subtest vcs0: SUCCESS (0.028s) [54.933562] Starting dynamic subtest: vcs1 [54.955638] Dynamic subtest vcs1: SUCCESS (0.033s) [54.966842] Starting dynamic subtest: vecs0 [54.984122] Dynamic subtest vecs0: SUCCESS (0.029s) [54.985197] Subtest basic-wait: SUCCESS (0.153s) [55.607641] [023/162] (948s left) gem_exec_fence (basic-await) [55.806339] Starting subtest: basic-await [55.807641] Starting dynamic subtest: rcs0 [55.922904] Dynamic subtest rcs0: SUCCESS (0.115s) [55.938858] Starting dynamic subtest: bcs0 [56.033244] Dynamic subtest bcs0: SUCCESS (0.110s) [56.049644] Starting dynamic subtest: vcs0 [56.143402] Dynamic subtest vcs0: SUCCESS (0.111s) [56.157364] Starting dynamic subtest: vcs1 [56.260297] Dynamic subtest vcs1: SUCCESS (0.116s) [56.278017] Starting dynamic subtest: vecs0 [56.383963] Dynamic subtest vecs0: SUCCESS (0.123s) [56.384961] Subtest basic-await: SUCCESS (0.577s) [57.053518] [024/162] (946s left) gem_exec_fence (nb-await) [57.269588] Starting subtest: nb-await [57.271284] Starting dynamic subtest: rcs0 [57.347889] Dynamic subtest rcs0: SUCCESS (0.077s) [57.365051] Starting dynamic subtest: bcs0 [57.420092] Dynamic subtest bcs0: SUCCESS (0.072s) [57.449525] Starting dynamic subtest: vcs0 [57.509121] Dynamic subtest vcs0: SUCCESS (0.086s) [57.538976] Starting dynamic subtest: vcs1 [57.593744] Dynamic subtest vcs1: SUCCESS (0.085s) [57.624184] Starting dynamic subtest: vecs0 [57.676522] Dynamic subtest vecs0: SUCCESS (0.083s) [57.678619] Subtest nb-await: SUCCESS (0.409s) [58.379917] [025/162] (945s left) gem_exec_gttfill (basic) [58.454191] Starting subtest: basic [63.255085] Subtest basic: SUCCESS (4.800s) [63.597889] [026/162] (940s left) gem_exec_parallel (engines) [64.044894] Starting subtest: engines [64.046700] Starting dynamic subtest: basic [66.430820] Dynamic subtest basic: SUCCESS (2.341s) [66.441826] Starting dynamic subtest: contexts [76.767396] Dynamic subtest contexts: SUCCESS (10.355s) [76.778775] Starting dynamic subtest: fds [80.506676] Dynamic subtest fds: SUCCESS (3.764s) [80.518344] Starting dynamic subtest: userptr [82.862691] Dynamic subtest userptr: SUCCESS (2.312s) [82.864999] Subtest engines: SUCCESS (18.774s) [83.022459] [027/162] (921s left) gem_exec_store (basic) [83.108718] Starting subtest: basic [83.168601] Subtest basic: SUCCESS (0.059s) [83.346845] [028/162] (920s left) gem_flink_basic (bad-flink) [83.404406] Starting subtest: bad-flink [83.405506] Subtest bad-flink: SUCCESS (0.000s) [83.457658] [029/162] (920s left) gem_flink_basic (bad-open) [83.514275] Starting subtest: bad-open [83.515404] Subtest bad-open: SUCCESS (0.000s) [83.620638] [030/162] (920s left) gem_flink_basic (basic) [83.816056] Starting subtest: basic [83.818307] Subtest basic: SUCCESS (0.000s) [83.908261] [031/162] (920s left) gem_flink_basic (double-flink) [84.009276] Starting subtest: double-flink [84.010412] Subtest double-flink: SUCCESS (0.000s) [84.103843] [032/162] (920s left) gem_flink_basic (flink-lifetime) [84.160429] Starting subtest: flink-lifetime [84.162526] Subtest flink-lifetime: SUCCESS (0.002s) [84.234596] [033/162] (920s left) gem_huc_copy (huc-copy) [84.301675] Starting subtest: huc-copy [84.303597] Subtest huc-copy: SKIP (0.000s) [84.383905] [034/162] (920s left) gem_linear_blits (basic) [84.560379] Starting subtest: basic [84.571652] Subtest basic: SUCCESS (0.013s) [84.659695] [035/162] (919s left) gem_mmap (basic) [84.816892] Starting subtest: basic [84.821871] Subtest basic: SUCCESS (0.000s) [84.898840] [036/162] (919s left) gem_mmap_gtt (basic) [84.956636] Starting subtest: basic [84.957580] Subtest basic: SUCCESS (0.001s) [85.013334] [037/162] (919s left) gem_render_linear_blits (basic) [85.080098] Starting subtest: basic [85.112481] Subtest basic: SUCCESS (0.033s) [85.182158] [038/162] (919s left) gem_render_tiled_blits (basic) [85.248742] Starting subtest: basic [85.289243] Subtest basic: SUCCESS (0.040s) [85.358574] [039/162] (919s left) gem_ringfill (basic-all) [85.645972] Starting subtest: basic-all [86.872631] Subtest basic-all: SUCCESS (1.171s) [86.933669] [040/162] (917s left) gem_softpin (allocator-basic) [87.007424] Starting subtest: allocator-basic [87.209057] Subtest allocator-basic: SUCCESS (0.146s) [87.260996] [041/162] (917s left) gem_softpin (allocator-basic-reserve) [87.330761] Starting subtest: allocator-basic-reserve [87.531818] Subtest allocator-basic-reserve: SUCCESS (0.145s) [87.583967] [042/162] (917s left) gem_softpin (safe-alignment) [87.656164] Starting subtest: safe-alignment [87.674330] Subtest safe-alignment: SUCCESS (0.018s) [87.766490] [043/162] (917s left) gem_sync (basic-all) [87.846983] Starting subtest: basic-all [90.333781] Subtest basic-all: SUCCESS (2.447s) [90.504234] [044/162] (914s left) gem_sync (basic-each) [90.599721] Starting subtest: basic-each [92.843614] Subtest basic-each: SUCCESS (2.243s) [93.135953] [045/162] (912s left) gem_tiled_blits (basic) [93.314355] Starting subtest: basic [93.334760] Subtest basic: SUCCESS (0.024s) [93.443682] [046/162] (911s left) gem_tiled_fence_blits (basic) [93.990402] Starting subtest: basic [94.001130] Subtest basic: SUCCESS (0.011s) [94.094619] [047/162] (911s left) gem_tiled_pread_basic (basic) [94.205233] Starting subtest: basic [94.417819] Subtest basic: SUCCESS (0.156s) [94.471753] [048/162] (911s left) gem_wait (busy@all-engines) [94.562891] Starting subtest: busy [94.564101] Starting dynamic subtest: all-engines [95.151422] Dynamic subtest all-engines: SUCCESS (0.587s) [95.154332] Subtest busy: SUCCESS (0.588s) [95.450224] [049/162] (910s left) gem_wait (wait@all-engines) [95.533192] Starting subtest: wait [95.534345] Starting dynamic subtest: all-engines [96.613480] Dynamic subtest all-engines: SUCCESS (1.031s) [96.616113] Subtest wait: SUCCESS (1.032s) [96.784289] [050/162] (908s left) i915_getparams_basic (basic-eu-total) [96.851428] Starting subtest: basic-eu-total [96.853574] Subtest basic-eu-total: SUCCESS (0.000s) [96.907169] [051/162] (908s left) i915_getparams_basic (basic-subslice-total) [96.966072] Starting subtest: basic-subslice-total [96.968188] Subtest basic-subslice-total: SUCCESS (0.000s) [97.020142] [052/162] (908s left) i915_hangman (error-state-basic) [97.099444] Starting subtest: error-state-basic [97.107073] Subtest error-state-basic: SUCCESS (0.008s) [97.315292] [053/162] (908s left) i915_pciid [97.678268] [054/162] (908s left) intel_hwmon (hwmon-read) [97.737083] Subtest hwmon-read: SKIP (0.000s) [97.791722] [055/162] (908s left) intel_hwmon (hwmon-write) [97.847938] Subtest hwmon-write: SKIP (0.000s) [97.902087] [056/162] (908s left) kms_addfb_basic (addfb25-4-tiled) [98.178598] Starting subtest: addfb25-4-tiled [98.179865] Subtest addfb25-4-tiled: SUCCESS (0.001s) [98.263632] [057/162] (907s left) kms_addfb_basic (addfb25-bad-modifier) [98.540527] Starting subtest: addfb25-bad-modifier [98.541759] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [98.619970] [058/162] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [98.898747] Starting subtest: addfb25-framebuffer-vs-set-tiling [98.899941] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [98.986425] [059/162] (907s left) kms_addfb_basic (addfb25-modifier-no-flag) [99.252492] Starting subtest: addfb25-modifier-no-flag [99.253966] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [99.332781] [060/162] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy) [99.596327] Starting subtest: addfb25-x-tiled-legacy [99.597481] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [99.672969] [061/162] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [99.945500] Starting subtest: addfb25-x-tiled-mismatch-legacy [99.947068] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [100.026958] [062/162] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [100.298944] Starting subtest: addfb25-yf-tiled-legacy [100.300263] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [100.387090] [063/162] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy) [100.663500] Starting subtest: addfb25-y-tiled-legacy [100.664618] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [100.749743] [064/162] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [101.017890] Starting subtest: addfb25-y-tiled-small-legacy [101.019275] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [101.103982] [065/162] (905s left) kms_addfb_basic (bad-pitch-0) [101.161757] Starting subtest: bad-pitch-0 [101.163325] Subtest bad-pitch-0: SUCCESS (0.000s) [101.469733] [066/162] (905s left) kms_addfb_basic (bad-pitch-1024) [101.526514] Starting subtest: bad-pitch-1024 [101.527474] Subtest bad-pitch-1024: SUCCESS (0.000s) [101.826046] [067/162] (905s left) kms_addfb_basic (bad-pitch-128) [101.882995] Starting subtest: bad-pitch-128 [101.884014] Subtest bad-pitch-128: SUCCESS (0.000s) [102.181290] [068/162] (904s left) kms_addfb_basic (bad-pitch-256) [102.238899] Starting subtest: bad-pitch-256 [102.239845] Subtest bad-pitch-256: SUCCESS (0.000s) [102.531815] [069/162] (904s left) kms_addfb_basic (bad-pitch-32) [102.589410] Starting subtest: bad-pitch-32 [102.590312] Subtest bad-pitch-32: SUCCESS (0.000s) [102.899198] [070/162] (904s left) kms_addfb_basic (bad-pitch-63) [102.956755] Starting subtest: bad-pitch-63 [102.957785] Subtest bad-pitch-63: SUCCESS (0.000s) [103.261133] [071/162] (903s left) kms_addfb_basic (bad-pitch-65536) [103.317352] Starting subtest: bad-pitch-65536 [103.318323] Subtest bad-pitch-65536: SUCCESS (0.000s) [103.614591] [072/162] (903s left) kms_addfb_basic (bad-pitch-999) [103.672178] Starting subtest: bad-pitch-999 [103.673100] Subtest bad-pitch-999: SUCCESS (0.000s) [103.976152] [073/162] (903s left) kms_addfb_basic (basic) [104.033210] Starting subtest: basic [104.034085] Subtest basic: SUCCESS (0.000s) [104.340117] [074/162] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [104.399492] Starting subtest: basic-x-tiled-legacy [104.400618] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [104.706428] [075/162] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [104.765056] Starting subtest: basic-y-tiled-legacy [104.766048] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [105.066348] [076/162] (902s left) kms_addfb_basic (bo-too-small) [105.337390] Starting subtest: bo-too-small [105.338389] Subtest bo-too-small: SUCCESS (0.001s) [105.417602] [077/162] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [105.679430] Starting subtest: bo-too-small-due-to-tiling [105.680540] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [105.766663] [078/162] (901s left) kms_addfb_basic (clobberred-modifier) [105.825302] Starting subtest: clobberred-modifier [105.826798] Subtest clobberred-modifier: SUCCESS (0.000s) [106.118302] [079/162] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [106.177798] Starting subtest: framebuffer-vs-set-tiling [106.178769] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [106.472768] [080/162] (901s left) kms_addfb_basic (invalid-get-prop) [106.531174] Starting subtest: invalid-get-prop [106.532138] Subtest invalid-get-prop: SUCCESS (0.000s) [106.827441] [081/162] (900s left) kms_addfb_basic (invalid-get-prop-any) [106.885925] Starting subtest: invalid-get-prop-any [106.886898] Subtest invalid-get-prop-any: SUCCESS (0.000s) [107.197577] [082/162] (900s left) kms_addfb_basic (invalid-set-prop) [107.257158] Starting subtest: invalid-set-prop [107.258589] Subtest invalid-set-prop: SUCCESS (0.000s) [107.559085] [083/162] (900s left) kms_addfb_basic (invalid-set-prop-any) [107.616126] Starting subtest: invalid-set-prop-any [107.617071] Subtest invalid-set-prop-any: SUCCESS (0.000s) [107.923548] [084/162] (900s left) kms_addfb_basic (no-handle) [107.985637] Starting subtest: no-handle [107.986576] Subtest no-handle: SUCCESS (0.000s) [108.285988] [085/162] (899s left) kms_addfb_basic (size-max) [108.563522] Starting subtest: size-max [108.564587] Subtest size-max: SUCCESS (0.000s) [108.657713] [086/162] (899s left) kms_addfb_basic (small-bo) [108.928056] Starting subtest: small-bo [108.929303] Subtest small-bo: SUCCESS (0.000s) [109.014689] [087/162] (899s left) kms_addfb_basic (tile-pitch-mismatch) [109.072286] Starting subtest: tile-pitch-mismatch [109.073263] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [109.367806] [088/162] (898s left) kms_addfb_basic (too-high) [109.639465] Starting subtest: too-high [109.642307] Subtest too-high: SUCCESS (0.002s) [109.722579] [089/162] (898s left) kms_addfb_basic (too-wide) [109.993562] Starting subtest: too-wide [109.994713] Subtest too-wide: SUCCESS (0.000s) [110.074676] [090/162] (898s left) kms_addfb_basic (unused-handle) [110.131458] Starting subtest: unused-handle [110.132502] Subtest unused-handle: SUCCESS (0.000s) [110.427405] [091/162] (898s left) kms_addfb_basic (unused-modifier) [110.485233] Starting subtest: unused-modifier [110.486161] Subtest unused-modifier: SUCCESS (0.000s) [110.783176] [092/162] (897s left) kms_addfb_basic (unused-offsets) [110.840276] Starting subtest: unused-offsets [110.841233] Subtest unused-offsets: SUCCESS (0.000s) [111.134994] [093/162] (897s left) kms_addfb_basic (unused-pitches) [111.192965] Starting subtest: unused-pitches [111.193951] Subtest unused-pitches: SUCCESS (0.000s) [111.491146] [094/162] (897s left) kms_busy (basic) [111.785194] Subtest basic: SKIP (0.000s) [111.850541] [095/162] (896s left) kms_prop_blob (basic) [111.908339] Starting subtest: basic [111.909288] Subtest basic: SUCCESS (0.000s) [111.965129] [096/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [112.242971] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [112.302465] [097/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [112.580611] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [112.636171] [098/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [112.921119] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [112.987228] [099/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [113.269169] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [113.327878] [100/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [113.606743] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [113.669699] [101/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [113.951213] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [114.006089] [102/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [114.288139] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [114.342423] [103/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [114.616972] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [114.674196] [104/162] (894s left) kms_dsc (dsc-basic) [114.947184] Subtest dsc-basic: SKIP (0.000s) [115.010345] [105/162] (894s left) kms_flip (basic-flip-vs-dpms) [115.277931] Starting subtest: basic-flip-vs-dpms [115.280333] Subtest basic-flip-vs-dpms: SKIP (0.003s) [115.365143] [106/162] (894s left) kms_flip (basic-flip-vs-modeset) [115.633190] Starting subtest: basic-flip-vs-modeset [115.637185] Subtest basic-flip-vs-modeset: SKIP (0.003s) [115.717415] [107/162] (893s left) kms_flip (basic-flip-vs-wf_vblank) [115.993717] Starting subtest: basic-flip-vs-wf_vblank [116.000217] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [116.082303] [108/162] (893s left) kms_flip (basic-plain-flip) [116.357046] Starting subtest: basic-plain-flip [116.359621] Subtest basic-plain-flip: SKIP (0.002s) [116.438212] [109/162] (893s left) kms_force_connector_basic (force-connector-state) [116.826150] Starting subtest: force-connector-state [117.617982] Subtest force-connector-state: SUCCESS (0.792s) [118.216109] [110/162] (891s left) kms_force_connector_basic (force-edid) [118.604722] Starting subtest: force-edid [119.246189] Subtest force-edid: SUCCESS (0.642s) [119.746119] [111/162] (889s left) kms_force_connector_basic (force-load-detect) [120.138458] Starting subtest: force-load-detect [120.140309] Subtest force-load-detect: SKIP (0.000s) [120.531833] [112/162] (889s left) kms_force_connector_basic (prune-stale-modes) [120.928472] Starting subtest: prune-stale-modes [121.670234] Subtest prune-stale-modes: SUCCESS (0.741s) [122.201456] [113/162] (887s left) kms_frontbuffer_tracking (basic) [122.471270] Subtest basic: SKIP (0.000s) [122.561885] [114/162] (887s left) kms_hdmi_inject (inject-audio) [122.621865] Starting subtest: inject-audio [123.240813] Subtest inject-audio: SUCCESS (0.618s) [123.499167] [115/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [123.772532] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [123.839400] [116/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [124.109792] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [124.185308] [117/162] (885s left) kms_pipe_crc_basic (hang-read-crc) [124.459202] Subtest hang-read-crc: SKIP (0.000s) [124.525169] [118/162] (885s left) kms_pipe_crc_basic (nonblocking-crc) [124.801731] Subtest nonblocking-crc: SKIP (0.000s) [124.873862] [119/162] (885s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [125.139493] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [125.213693] [120/162] (885s left) kms_pipe_crc_basic (read-crc) [125.480174] Subtest read-crc: SKIP (0.000s) [125.550168] [121/162] (884s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.823856] Subtest read-crc-frame-sequence: SKIP (0.000s) [125.889325] [122/162] (884s left) kms_pm_backlight (basic-brightness) [126.163265] Subtest basic-brightness: SKIP (0.000s) [126.237456] [123/162] (884s left) kms_pm_rpm (basic-pci-d3-state) [127.878461] Starting subtest: basic-pci-d3-state [128.218702] Subtest basic-pci-d3-state: SUCCESS (0.343s) [128.385799] [124/162] (882s left) kms_pm_rpm (basic-rte) [128.750967] Starting subtest: basic-rte [130.610368] Subtest basic-rte: SUCCESS (1.856s) [131.076214] [125/162] (879s left) kms_psr (psr-primary-page-flip) [131.621933] Subtest psr-primary-page-flip: SKIP (0.000s) [131.695584] [126/162] (878s left) kms_psr (psr-cursor-plane-move) [131.971292] Subtest psr-cursor-plane-move: SKIP (0.000s) [132.047277] [127/162] (878s left) kms_psr (psr-sprite-plane-onoff) [132.318501] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [132.393070] [128/162] (878s left) kms_psr (psr-primary-mmap-gtt) [132.666369] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [132.742284] [129/162] (878s left) kms_setmode (basic-clone-single-crtc) [132.800302] Starting subtest: basic-clone-single-crtc [132.803374] Subtest basic-clone-single-crtc: SKIP (0.000s) [132.864116] [130/162] (878s left) i915_pm_rps (basic-api) [132.938179] Starting subtest: basic-api [132.942951] Subtest basic-api: SUCCESS (0.005s) [133.024394] [131/162] (877s left) prime_self_import (basic-llseek-bad) [133.083805] Starting subtest: basic-llseek-bad [133.086889] Subtest basic-llseek-bad: SUCCESS (0.003s) [133.163887] [132/162] (877s left) prime_self_import (basic-llseek-size) [133.218017] Starting subtest: basic-llseek-size [133.222039] Subtest basic-llseek-size: SUCCESS (0.004s) [133.306049] [133/162] (877s left) prime_self_import (basic-with_fd_dup) [133.361933] Starting subtest: basic-with_fd_dup [133.365460] Subtest basic-with_fd_dup: SUCCESS (0.005s) [133.446036] [134/162] (877s left) prime_self_import (basic-with_one_bo) [133.503385] Starting subtest: basic-with_one_bo [133.506804] Subtest basic-with_one_bo: SUCCESS (0.005s) [133.575578] [135/162] (877s left) prime_self_import (basic-with_one_bo_two_files) [133.629537] Starting subtest: basic-with_one_bo_two_files [133.632936] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [133.716935] [136/162] (877s left) prime_self_import (basic-with_two_bos) [133.773447] Starting subtest: basic-with_two_bos [133.776896] Subtest basic-with_two_bos: SUCCESS (0.004s) [133.859195] [137/162] (877s left) prime_vgem (basic-fence-flip) [133.934151] Starting subtest: basic-fence-flip [134.146825] Subtest basic-fence-flip: SKIP (0.209s) [134.222666] [138/162] (877s left) prime_vgem (basic-fence-mmap) [134.294637] Starting subtest: basic-fence-mmap [134.326505] Subtest basic-fence-mmap: SUCCESS (0.032s) [134.392626] [139/162] (877s left) prime_vgem (basic-fence-read) [134.464949] Starting subtest: basic-fence-read [134.535666] Subtest basic-fence-read: SUCCESS (0.071s) [134.607610] [140/162] (876s left) prime_vgem (basic-gtt) [134.675085] Starting subtest: basic-gtt [134.689491] Subtest basic-gtt: SUCCESS (0.015s) [134.780999] [141/162] (876s left) prime_vgem (basic-read) [134.847256] Starting subtest: basic-read [134.879901] Subtest basic-read: SUCCESS (0.032s) [134.967511] [142/162] (876s left) prime_vgem (basic-write) [135.034840] Starting subtest: basic-write [135.069562] Subtest basic-write: SUCCESS (0.035s) [135.136193] [143/162] (876s left) vgem_basic (setversion) [135.197887] Starting subtest: setversion [135.199767] Subtest setversion: SUCCESS (0.000s) [135.258399] [144/162] (876s left) vgem_basic (create) [135.316142] Starting subtest: create [135.317041] Subtest create: SUCCESS (0.000s) [135.376363] [145/162] (876s left) vgem_basic (debugfs) [135.435976] Starting subtest: debugfs [135.436930] Subtest debugfs: SUCCESS (0.000s) [135.496086] [146/162] (876s left) vgem_basic (dmabuf-export) [135.568248] Starting subtest: dmabuf-export [135.578563] Subtest dmabuf-export: SUCCESS (0.010s) [135.651389] [147/162] (876s left) vgem_basic (dmabuf-fence) [135.711902] Starting subtest: dmabuf-fence [135.713014] Subtest dmabuf-fence: SUCCESS (0.001s) [135.772975] [148/162] (876s left) vgem_basic (dmabuf-fence-before) [135.832016] Starting subtest: dmabuf-fence-before [135.832979] Subtest dmabuf-fence-before: SUCCESS (0.001s) [135.896217] [149/162] (876s left) vgem_basic (dmabuf-mmap) [135.955923] Starting subtest: dmabuf-mmap [135.969643] Subtest dmabuf-mmap: SUCCESS (0.015s) [136.036656] [150/162] (876s left) vgem_basic (mmap) [136.095018] Starting subtest: mmap [136.106240] Subtest mmap: SUCCESS (0.011s) [136.165912] [151/162] (876s left) vgem_basic (second-client) [136.224496] Starting subtest: second-client [136.227803] Subtest second-client: SUCCESS (0.004s) [136.288384] [152/162] (875s left) vgem_basic (sysfs) [136.348113] Starting subtest: sysfs [136.349076] Subtest sysfs: SUCCESS (0.001s) [136.409473] [153/162] (875s left) core_hotunplug (unbind-rebind) [136.518231] Starting subtest: unbind-rebind [140.882269] Subtest unbind-rebind: SUCCESS (4.357s) [140.936369] [154/162] (871s left) vgem_basic (unload) [141.004229] Starting subtest: unload [169.951219] Subtest unload: SUCCESS (28.893s) [170.006489] [155/162] (842s left) i915_module_load (reload) [170.073027] Starting subtest: reload [173.655179] Subtest reload: SUCCESS (3.583s) [173.744586] [156/162] (838s left) gem_lmem_swapping (basic) [174.040899] Subtest basic: SKIP (0.000s) [174.149579] [157/162] (838s left) gem_lmem_swapping (parallel-random-engines) [174.214057] Subtest parallel-random-engines: SKIP (0.000s) [174.268914] [158/162] (838s left) gem_lmem_swapping (random-engines) [174.333545] Subtest random-engines: SKIP (0.000s) [174.387134] [159/162] (838s left) gem_lmem_swapping (verify-random) [174.452546] Subtest verify-random: SKIP (0.000s) [174.507769] [160/162] (838s left) i915_pm_rpm (module-reload) [177.491273] Starting subtest: module-reload [192.313450] Subtest module-reload: SUCCESS (14.770s) [192.379789] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [192.381264] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [192.384292] [161/162] (820s left) i915_selftest (live) [192.462648] Starting subtest: live [192.464046] Starting dynamic subtest: sanitycheck [195.334086] Dynamic subtest sanitycheck: SUCCESS (2.816s) [195.344791] Starting dynamic subtest: uncore [198.131786] Dynamic subtest uncore: SUCCESS (2.797s) [198.142477] Starting dynamic subtest: workarounds [201.285913] Dynamic subtest workarounds: SUCCESS (3.153s) [201.296574] Starting dynamic subtest: gt_engines [204.626996] Dynamic subtest gt_engines: SUCCESS (3.340s) [204.637686] Starting dynamic subtest: gt_timelines [220.543139] Dynamic subtest gt_timelines: SUCCESS (15.915s) [220.553876] Starting dynamic subtest: gt_contexts [223.431534] Dynamic subtest gt_contexts: SUCCESS (2.940s) [223.442084] Starting dynamic subtest: gt_lrc [229.492061] Dynamic subtest gt_lrc: SUCCESS (6.007s) [229.502783] Starting dynamic subtest: gt_mocs [232.391287] Dynamic subtest gt_mocs: SUCCESS (2.898s) [232.402051] Starting dynamic subtest: gt_pm [243.837085] Dynamic subtest gt_pm: SUCCESS (11.445s) [243.847728] Starting dynamic subtest: gt_heartbeat [246.632788] Dynamic subtest gt_heartbeat: SUCCESS (2.795s) [246.643707] Starting dynamic subtest: gt_tlb [251.115882] Dynamic subtest gt_tlb: SUCCESS (4.482s) [251.126583] Starting dynamic subtest: requests [261.351103] Dynamic subtest requests: SUCCESS (10.234s) [261.361891] Starting dynamic subtest: migrate [267.048022] Dynamic subtest migrate: SUCCESS (5.696s) [267.062300] Starting dynamic subtest: active [269.854784] Dynamic subtest active: SUCCESS (2.805s) [269.869070] Starting dynamic subtest: objects [273.544752] Dynamic subtest objects: SUCCESS (3.689s) [273.559148] Starting dynamic subtest: mman [279.892920] Dynamic subtest mman: SUCCESS (6.346s) [279.903842] Starting dynamic subtest: dmabuf [282.741036] Dynamic subtest dmabuf: SUCCESS (2.846s) [282.751819] Starting dynamic subtest: vma [285.469063] Dynamic subtest vma: SUCCESS (2.778s) [285.483438] Starting dynamic subtest: coherency [289.470307] Dynamic subtest coherency: SUCCESS (3.947s) [289.484626] Starting dynamic subtest: gtt [299.489016] Dynamic subtest gtt: SUCCESS (10.017s) [299.499851] Starting dynamic subtest: gem [302.811144] Dynamic subtest gem: SUCCESS (3.320s) [302.825435] Starting dynamic subtest: evict [307.936279] Dynamic subtest evict: SUCCESS (5.123s) [307.947273] Starting dynamic subtest: hugepages [317.205213] Dynamic subtest hugepages: SUCCESS (9.267s) [317.216224] Starting dynamic subtest: gem_contexts [337.164850] Dynamic subtest gem_contexts: SUCCESS (19.957s) [337.175706] Starting dynamic subtest: client [340.030979] Dynamic subtest client: SUCCESS (2.864s) [340.041874] Starting dynamic subtest: gem_migrate [342.820765] Dynamic subtest gem_migrate: SUCCESS (2.788s) [342.835065] Starting dynamic subtest: reset [346.034080] Dynamic subtest reset: SUCCESS (3.211s) [346.045018] Starting dynamic subtest: memory_region [348.839974] Dynamic subtest memory_region: SUCCESS (2.804s) [348.850945] Starting dynamic subtest: hangcheck [380.328208] Dynamic subtest hangcheck: SUCCESS (31.485s) [380.339066] Starting dynamic subtest: execlists [396.080495] Dynamic subtest execlists: SUCCESS (15.750s) [396.091354] Starting dynamic subtest: ring_submission [398.874130] Dynamic subtest ring_submission: SUCCESS (2.792s) [398.885052] Starting dynamic subtest: perf [401.718851] Dynamic subtest perf: SUCCESS (2.843s) [401.729862] Starting dynamic subtest: slpc [404.474988] Dynamic subtest slpc: SUCCESS (2.754s) [404.488105] Starting dynamic subtest: guc [407.261834] Dynamic subtest guc: SUCCESS (2.785s) [407.272677] Starting dynamic subtest: guc_multi_lrc [410.054017] Dynamic subtest guc_multi_lrc: SUCCESS (2.790s) [410.064924] Starting dynamic subtest: guc_hang [412.846160] Dynamic subtest guc_hang: SUCCESS (2.797s) [412.857009] Starting dynamic subtest: late_gt_pm [415.645933] Dynamic subtest late_gt_pm: SUCCESS (2.791s) [415.648181] Subtest live: SUCCESS (223.124s) [415.720557] [162/162] (597s left) dmabuf (all-tests) [415.792928] Starting subtest: all-tests [415.794227] Starting dynamic subtest: sanitycheck [415.855211] Dynamic subtest sanitycheck: SUCCESS (0.061s) [415.892067] Starting dynamic subtest: dma_fence [416.076151] Dynamic subtest dma_fence: SUCCESS (0.214s) [416.103470] Starting dynamic subtest: dma_fence_chain [416.106552] Dynamic subtest dma_fence_chain: SKIP (0.001s) [416.136036] Starting dynamic subtest: dma_fence_unwrap [416.175163] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s) [416.212699] Starting dynamic subtest: dma_resv [416.252240] Dynamic subtest dma_resv: SUCCESS (0.072s) [416.259405] Subtest all-tests: SUCCESS (0.462s) [416.351739] 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.