[34.601782] Initializing watchdogs [34.601887] /dev/watchdog0 [34.626662] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [34.634618] [001/162] (960s left) i915_module_load (load) [34.744114] Starting subtest: load [37.113960] Subtest load: SUCCESS (2.369s) [37.201484] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [37.203588] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [37.209684] [002/162] (958s left) core_auth (basic-auth) [37.377188] Starting subtest: basic-auth [37.381306] Subtest basic-auth: SUCCESS (0.004s) [37.466951] [003/162] (957s left) core_debugfs (read-all-entries) [37.525430] Starting subtest: read-all-entries [37.529375] Subtest read-all-entries: SUCCESS (0.005s) [37.579932] [004/162] (957s left) core_sysfs (read-all-entries) [37.637668] Starting subtest: read-all-entries [37.641800] Subtest read-all-entries: SUCCESS (0.005s) [37.689782] [005/162] (957s left) fbdev (eof) [37.757982] Subtest eof: SKIP (0.000s) [37.803821] [006/162] (957s left) fbdev (info) [37.871367] Subtest info: SKIP (0.000s) [37.916734] [007/162] (957s left) fbdev (nullptr) [37.983289] Subtest nullptr: SKIP (0.000s) [38.028953] [008/162] (957s left) fbdev (read) [38.096209] Subtest read: SKIP (0.000s) [38.142063] [009/162] (957s left) fbdev (write) [38.209810] Subtest write: SKIP (0.000s) [38.254159] [010/162] (957s left) gem_basic (bad-close) [38.310104] Starting subtest: bad-close [38.312170] Subtest bad-close: SUCCESS (0.000s) [38.357569] [011/162] (957s left) gem_basic (create-close) [38.414964] Starting subtest: create-close [38.416852] Subtest create-close: SUCCESS (0.000s) [38.477371] [012/162] (957s left) gem_basic (create-fd-close) [38.536545] Starting subtest: create-fd-close [38.539153] Subtest create-fd-close: SUCCESS (0.000s) [38.602769] [013/162] (957s left) gem_busy (busy@all-engines) [38.682999] Starting subtest: busy [38.684062] Starting dynamic subtest: all-engines [38.751418] Dynamic subtest all-engines: SUCCESS (0.068s) [38.752367] Subtest busy: SUCCESS (0.069s) [39.154785] [014/162] (956s left) gem_close_race (basic-process) [39.241788] Starting subtest: basic-process [39.311397] Subtest basic-process: SUCCESS (0.070s) [39.556508] [015/162] (956s left) gem_close_race (basic-threads) [39.641568] Starting subtest: basic-threads [40.803309] Subtest basic-threads: SUCCESS (1.163s) [40.999648] [016/162] (955s left) gem_ctx_create (basic) [41.080276] Starting subtest: basic [41.082057] Subtest basic: SUCCESS (0.000s) [41.266023] [017/162] (954s left) gem_ctx_create (basic-files) [41.339013] Starting subtest: basic-files [43.356415] Subtest basic-files: SUCCESS (2.018s) [43.565542] [018/162] (952s left) gem_ctx_exec (basic) [43.671524] Starting subtest: basic [43.683487] Subtest basic: SUCCESS (0.012s) [43.770782] [019/162] (952s left) gem_exec_basic (basic) [43.836922] Starting subtest: basic [43.838413] Starting dynamic subtest: rcs0-smem [43.840763] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [43.852070] Starting dynamic subtest: bcs0-smem [43.853090] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [43.862121] Starting dynamic subtest: vcs0-smem [43.863295] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [43.872163] Starting dynamic subtest: vcs1-smem [43.873343] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [43.882415] Starting dynamic subtest: vecs0-smem [43.883632] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [43.884746] Subtest basic: SUCCESS (0.011s) [44.054660] [020/162] (952s left) gem_exec_create (basic) [44.131746] Starting subtest: basic [44.133273] Starting dynamic subtest: smem [46.220465] Dynamic subtest smem: SUCCESS (2.053s) [46.222330] Subtest basic: SUCCESS (2.053s) [46.356837] [021/162] (949s left) gem_exec_fence (basic-busy) [46.593142] Starting subtest: basic-busy [46.594576] Starting dynamic subtest: rcs0 [46.621596] Dynamic subtest rcs0: SUCCESS (0.031s) [46.632657] Starting dynamic subtest: bcs0 [46.646396] Dynamic subtest bcs0: SUCCESS (0.024s) [46.656222] Starting dynamic subtest: vcs0 [46.670368] Dynamic subtest vcs0: SUCCESS (0.024s) [46.680094] Starting dynamic subtest: vcs1 [46.692396] Dynamic subtest vcs1: SUCCESS (0.022s) [46.702110] Starting dynamic subtest: vecs0 [46.711384] Dynamic subtest vecs0: SUCCESS (0.019s) [46.712744] Subtest basic-busy: SUCCESS (0.121s) [47.415373] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [47.417812] [022/162] (948s left) gem_exec_fence (basic-wait) [47.645467] Starting subtest: basic-wait [47.647171] Starting dynamic subtest: rcs0 [47.676384] Dynamic subtest rcs0: SUCCESS (0.031s) [47.688195] Starting dynamic subtest: bcs0 [47.700554] Dynamic subtest bcs0: SUCCESS (0.024s) [47.711735] Starting dynamic subtest: vcs0 [47.726491] Dynamic subtest vcs0: SUCCESS (0.026s) [47.736211] Starting dynamic subtest: vcs1 [47.745370] Dynamic subtest vcs1: SUCCESS (0.019s) [47.754930] Starting dynamic subtest: vecs0 [47.766401] Dynamic subtest vecs0: SUCCESS (0.021s) [47.767757] Subtest basic-wait: SUCCESS (0.122s) [48.413826] [023/162] (948s left) gem_exec_fence (basic-await) [48.625200] Starting subtest: basic-await [48.627051] Starting dynamic subtest: rcs0 [48.738926] Dynamic subtest rcs0: SUCCESS (0.109s) [48.753496] Starting dynamic subtest: bcs0 [48.846704] Dynamic subtest bcs0: SUCCESS (0.111s) [48.859876] Starting dynamic subtest: vcs0 [48.970600] Dynamic subtest vcs0: SUCCESS (0.117s) [48.984304] Starting dynamic subtest: vcs1 [49.095752] Dynamic subtest vcs1: SUCCESS (0.123s) [49.113119] Starting dynamic subtest: vecs0 [49.284301] Dynamic subtest vecs0: SUCCESS (0.137s) [49.287059] Subtest basic-await: SUCCESS (0.601s) [49.936182] [024/162] (946s left) gem_exec_fence (nb-await) [50.161660] Starting subtest: nb-await [50.163985] Starting dynamic subtest: rcs0 [50.239216] Dynamic subtest rcs0: SUCCESS (0.077s) [50.256968] Starting dynamic subtest: bcs0 [50.314842] Dynamic subtest bcs0: SUCCESS (0.074s) [50.342269] Starting dynamic subtest: vcs0 [50.399972] Dynamic subtest vcs0: SUCCESS (0.084s) [50.435298] Starting dynamic subtest: vcs1 [50.492442] Dynamic subtest vcs1: SUCCESS (0.091s) [50.520634] Starting dynamic subtest: vecs0 [50.576715] Dynamic subtest vecs0: SUCCESS (0.082s) [50.578982] Subtest nb-await: SUCCESS (0.415s) [51.285871] [025/162] (945s left) gem_exec_gttfill (basic) [51.371139] Starting subtest: basic [55.938999] Subtest basic: SUCCESS (4.568s) [56.194773] [026/162] (940s left) gem_exec_parallel (engines) [56.354205] Starting subtest: engines [56.355288] Starting dynamic subtest: basic [58.700370] Dynamic subtest basic: SUCCESS (2.302s) [58.711533] Starting dynamic subtest: contexts [63.772395] Dynamic subtest contexts: SUCCESS (5.115s) [63.783381] Starting dynamic subtest: fds [66.738902] Dynamic subtest fds: SUCCESS (2.964s) [66.750234] Starting dynamic subtest: userptr [69.892383] Dynamic subtest userptr: SUCCESS (3.113s) [69.894462] Subtest engines: SUCCESS (13.496s) [70.052455] [027/162] (926s left) gem_exec_store (basic) [70.134843] Starting subtest: basic [70.208036] Subtest basic: SUCCESS (0.073s) [70.394720] [028/162] (926s left) gem_flink_basic (bad-flink) [70.454158] Starting subtest: bad-flink [70.455324] Subtest bad-flink: SUCCESS (0.000s) [70.508965] [029/162] (926s left) gem_flink_basic (bad-open) [70.567271] Starting subtest: bad-open [70.568413] Subtest bad-open: SUCCESS (0.000s) [70.623434] [030/162] (926s left) gem_flink_basic (basic) [70.945957] Starting subtest: basic [70.948620] Subtest basic: SUCCESS (0.000s) [71.028894] [031/162] (925s left) gem_flink_basic (double-flink) [71.084169] Starting subtest: double-flink [71.085236] Subtest double-flink: SUCCESS (0.000s) [71.154769] [032/162] (925s left) gem_flink_basic (flink-lifetime) [71.211574] Starting subtest: flink-lifetime [71.214691] Subtest flink-lifetime: SUCCESS (0.002s) [71.286129] [033/162] (925s left) gem_huc_copy (huc-copy) [71.352293] Starting subtest: huc-copy [71.354309] Subtest huc-copy: SKIP (0.000s) [71.433935] [034/162] (925s left) gem_linear_blits (basic) [71.600049] Starting subtest: basic [71.609618] Subtest basic: SUCCESS (0.010s) [71.803027] [035/162] (925s left) gem_mmap (basic) [71.919414] Starting subtest: basic [71.923924] Subtest basic: SUCCESS (0.001s) [71.992294] [036/162] (925s left) gem_mmap_gtt (basic) [72.048619] Starting subtest: basic [72.049661] Subtest basic: SUCCESS (0.001s) [72.105115] [037/162] (925s left) gem_render_linear_blits (basic) [72.170794] Starting subtest: basic [72.203970] Subtest basic: SUCCESS (0.033s) [72.270592] [038/162] (925s left) gem_render_tiled_blits (basic) [72.339222] Starting subtest: basic [72.379144] Subtest basic: SUCCESS (0.041s) [72.446692] [039/162] (925s left) gem_ringfill (basic-all) [72.729313] Starting subtest: basic-all [73.955232] Subtest basic-all: SUCCESS (1.169s) [74.020475] [040/162] (923s left) gem_softpin (allocator-basic) [74.093117] Starting subtest: allocator-basic [74.296159] Subtest allocator-basic: SUCCESS (0.147s) [74.348224] [041/162] (923s left) gem_softpin (allocator-basic-reserve) [74.424746] Starting subtest: allocator-basic-reserve [74.619337] Subtest allocator-basic-reserve: SUCCESS (0.139s) [74.673037] [042/162] (922s left) gem_softpin (safe-alignment) [74.748582] Starting subtest: safe-alignment [74.767293] Subtest safe-alignment: SUCCESS (0.018s) [74.847806] [043/162] (922s left) gem_sync (basic-all) [74.926837] Starting subtest: basic-all [77.199893] Subtest basic-all: SUCCESS (2.237s) [77.362834] [044/162] (920s left) gem_sync (basic-each) [77.446518] Starting subtest: basic-each [79.701745] Subtest basic-each: SUCCESS (2.257s) [80.011756] [045/162] (917s left) gem_tiled_blits (basic) [80.174620] Starting subtest: basic [80.194815] Subtest basic: SUCCESS (0.020s) [80.329438] [046/162] (917s left) gem_tiled_fence_blits (basic) [80.924152] Starting subtest: basic [80.934989] Subtest basic: SUCCESS (0.011s) [81.029113] [047/162] (917s left) gem_tiled_pread_basic [81.342354] [048/162] (916s left) gem_wait (busy@all-engines) [81.424539] Starting subtest: busy [81.425627] Starting dynamic subtest: all-engines [81.991794] Dynamic subtest all-engines: SUCCESS (0.522s) [81.993913] Subtest busy: SUCCESS (0.522s) [82.161613] [049/162] (916s left) gem_wait (wait@all-engines) [82.250933] Starting subtest: wait [82.252274] Starting dynamic subtest: all-engines [83.351247] Dynamic subtest all-engines: SUCCESS (1.099s) [83.353624] Subtest wait: SUCCESS (1.100s) [83.646353] [050/162] (914s left) i915_getparams_basic (basic-eu-total) [83.711455] Starting subtest: basic-eu-total [83.714268] Subtest basic-eu-total: SUCCESS (0.000s) [83.766810] [051/162] (914s left) i915_getparams_basic (basic-subslice-total) [83.823874] Starting subtest: basic-subslice-total [83.827301] Subtest basic-subslice-total: SUCCESS (0.000s) [83.880587] [052/162] (914s left) i915_hangman (error-state-basic) [83.959742] Starting subtest: error-state-basic [83.968176] Subtest error-state-basic: SUCCESS (0.008s) [84.079537] [053/162] (914s left) i915_pciid [84.432342] [054/162] (914s left) intel_hwmon (hwmon-read) [84.491947] Subtest hwmon-read: SKIP (0.000s) [84.547969] [055/162] (914s left) intel_hwmon (hwmon-write) [84.606236] Subtest hwmon-write: SKIP (0.000s) [84.661169] [056/162] (914s left) kms_addfb_basic (addfb25-4-tiled) [84.940689] Starting subtest: addfb25-4-tiled [84.942237] Subtest addfb25-4-tiled: SUCCESS (0.001s) [85.018190] [057/162] (913s left) kms_addfb_basic (addfb25-bad-modifier) [85.292887] Starting subtest: addfb25-bad-modifier [85.294214] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [85.380298] [058/162] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [85.655528] Starting subtest: addfb25-framebuffer-vs-set-tiling [85.656747] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.737693] [059/162] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [86.028890] Starting subtest: addfb25-modifier-no-flag [86.031203] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [86.128173] [060/162] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [86.399730] Starting subtest: addfb25-x-tiled-legacy [86.400954] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [86.484393] [061/162] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [86.764404] Starting subtest: addfb25-x-tiled-mismatch-legacy [86.766315] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [86.862446] [062/162] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [87.136462] Starting subtest: addfb25-yf-tiled-legacy [87.137548] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [87.213219] [063/162] (911s left) kms_addfb_basic (addfb25-y-tiled-legacy) [87.483789] Starting subtest: addfb25-y-tiled-legacy [87.485342] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [87.568607] [064/162] (911s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [87.836800] Starting subtest: addfb25-y-tiled-small-legacy [87.838169] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [87.918273] [065/162] (911s left) kms_addfb_basic (bad-pitch-0) [87.976629] Starting subtest: bad-pitch-0 [87.977651] Subtest bad-pitch-0: SUCCESS (0.000s) [88.281719] [066/162] (911s left) kms_addfb_basic (bad-pitch-1024) [88.338332] Starting subtest: bad-pitch-1024 [88.339344] Subtest bad-pitch-1024: SUCCESS (0.000s) [88.643131] [067/162] (910s left) kms_addfb_basic (bad-pitch-128) [88.699655] Starting subtest: bad-pitch-128 [88.700695] Subtest bad-pitch-128: SUCCESS (0.000s) [89.007171] [068/162] (910s left) kms_addfb_basic (bad-pitch-256) [89.066446] Starting subtest: bad-pitch-256 [89.067408] Subtest bad-pitch-256: SUCCESS (0.000s) [89.344494] [069/162] (910s left) kms_addfb_basic (bad-pitch-32) [89.402273] Starting subtest: bad-pitch-32 [89.403567] Subtest bad-pitch-32: SUCCESS (0.000s) [89.701293] [070/162] (909s left) kms_addfb_basic (bad-pitch-63) [89.760231] Starting subtest: bad-pitch-63 [89.761282] Subtest bad-pitch-63: SUCCESS (0.000s) [90.083560] [071/162] (909s left) kms_addfb_basic (bad-pitch-65536) [90.142272] Starting subtest: bad-pitch-65536 [90.143783] Subtest bad-pitch-65536: SUCCESS (0.000s) [90.440886] [072/162] (909s left) kms_addfb_basic (bad-pitch-999) [90.499466] Starting subtest: bad-pitch-999 [90.500548] Subtest bad-pitch-999: SUCCESS (0.000s) [90.799871] [073/162] (909s left) kms_addfb_basic (basic) [90.858539] Starting subtest: basic [90.859476] Subtest basic: SUCCESS (0.000s) [91.164097] [074/162] (908s left) kms_addfb_basic (basic-x-tiled-legacy) [91.222587] Starting subtest: basic-x-tiled-legacy [91.223490] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [91.533600] [075/162] (908s left) kms_addfb_basic (basic-y-tiled-legacy) [91.592502] Starting subtest: basic-y-tiled-legacy [91.593533] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [91.893709] [076/162] (908s left) kms_addfb_basic (bo-too-small) [92.169746] Starting subtest: bo-too-small [92.170955] Subtest bo-too-small: SUCCESS (0.001s) [92.257874] [077/162] (907s left) kms_addfb_basic (bo-too-small-due-to-tiling) [92.530124] Starting subtest: bo-too-small-due-to-tiling [92.531773] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [92.628973] [078/162] (907s left) kms_addfb_basic (clobberred-modifier) [92.698079] Starting subtest: clobberred-modifier [92.700771] Subtest clobberred-modifier: SUCCESS (0.000s) [93.003409] [079/162] (907s left) kms_addfb_basic (framebuffer-vs-set-tiling) [93.062209] Starting subtest: framebuffer-vs-set-tiling [93.063186] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.360630] [080/162] (906s left) kms_addfb_basic (invalid-get-prop) [93.419602] Starting subtest: invalid-get-prop [93.421135] Subtest invalid-get-prop: SUCCESS (0.000s) [93.722685] [081/162] (906s left) kms_addfb_basic (invalid-get-prop-any) [93.780147] Starting subtest: invalid-get-prop-any [93.781163] Subtest invalid-get-prop-any: SUCCESS (0.000s) [94.094279] [082/162] (906s left) kms_addfb_basic (invalid-set-prop) [94.151214] Starting subtest: invalid-set-prop [94.152172] Subtest invalid-set-prop: SUCCESS (0.000s) [94.453933] [083/162] (906s left) kms_addfb_basic (invalid-set-prop-any) [94.511299] Starting subtest: invalid-set-prop-any [94.512305] Subtest invalid-set-prop-any: SUCCESS (0.000s) [94.803098] [084/162] (905s left) kms_addfb_basic (no-handle) [94.859825] Starting subtest: no-handle [94.861350] Subtest no-handle: SUCCESS (0.000s) [95.149491] [085/162] (905s left) kms_addfb_basic (size-max) [95.419290] Starting subtest: size-max [95.420529] Subtest size-max: SUCCESS (0.000s) [95.510724] [086/162] (905s left) kms_addfb_basic (small-bo) [95.784414] Starting subtest: small-bo [95.785870] Subtest small-bo: SUCCESS (0.000s) [95.868355] [087/162] (904s left) kms_addfb_basic (tile-pitch-mismatch) [95.926616] Starting subtest: tile-pitch-mismatch [95.927561] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [96.234660] [088/162] (904s left) kms_addfb_basic (too-high) [96.513026] Starting subtest: too-high [96.514781] Subtest too-high: SUCCESS (0.002s) [96.601556] [089/162] (904s left) kms_addfb_basic (too-wide) [96.873931] Starting subtest: too-wide [96.877258] Subtest too-wide: SUCCESS (0.000s) [96.965457] [090/162] (904s left) kms_addfb_basic (unused-handle) [97.023062] Starting subtest: unused-handle [97.024112] Subtest unused-handle: SUCCESS (0.000s) [97.328767] [091/162] (903s left) kms_addfb_basic (unused-modifier) [97.384652] Starting subtest: unused-modifier [97.385682] Subtest unused-modifier: SUCCESS (0.000s) [97.679752] [092/162] (903s left) kms_addfb_basic (unused-offsets) [97.738437] Starting subtest: unused-offsets [97.739911] Subtest unused-offsets: SUCCESS (0.000s) [98.041523] [093/162] (903s left) kms_addfb_basic (unused-pitches) [98.097497] Starting subtest: unused-pitches [98.098452] Subtest unused-pitches: SUCCESS (0.000s) [98.410560] [094/162] (902s left) kms_busy (basic) [98.711878] Subtest basic: SKIP (0.000s) [98.782637] [095/162] (902s left) kms_prop_blob (basic) [98.840222] Starting subtest: basic [98.841237] Subtest basic: SUCCESS (0.000s) [98.894644] [096/162] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [99.174225] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [99.229791] [097/162] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [99.506516] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [99.568855] [098/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [99.853399] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [99.910804] [099/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [100.190066] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [100.246958] [100/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [100.533090] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [100.601758] [101/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [100.880234] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [100.939162] [102/162] (900s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [101.228773] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [101.286067] [103/162] (900s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [101.575349] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [101.632406] [104/162] (900s left) kms_dsc (dsc-basic) [101.904825] Subtest dsc-basic: SKIP (0.000s) [101.977982] [105/162] (899s left) kms_flip (basic-flip-vs-dpms) [102.248693] Starting subtest: basic-flip-vs-dpms [102.251113] Subtest basic-flip-vs-dpms: SKIP (0.003s) [102.325587] [106/162] (899s left) kms_flip (basic-flip-vs-modeset) [102.597993] Starting subtest: basic-flip-vs-modeset [102.601781] Subtest basic-flip-vs-modeset: SKIP (0.003s) [102.679234] [107/162] (899s left) kms_flip (basic-flip-vs-wf_vblank) [102.953882] Starting subtest: basic-flip-vs-wf_vblank [102.956318] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [103.032639] [108/162] (899s left) kms_flip (basic-plain-flip) [103.312420] Starting subtest: basic-plain-flip [103.321427] Subtest basic-plain-flip: SKIP (0.006s) [103.396863] [109/162] (898s left) kms_force_connector_basic (force-connector-state) [103.790238] Starting subtest: force-connector-state [104.575051] Subtest force-connector-state: SUCCESS (0.784s) [105.184094] [110/162] (897s left) kms_force_connector_basic (force-edid) [105.577917] Starting subtest: force-edid [106.244081] Subtest force-edid: SUCCESS (0.667s) [106.752831] [111/162] (895s left) kms_force_connector_basic (force-load-detect) [107.145421] Starting subtest: force-load-detect [107.147378] Subtest force-load-detect: SKIP (0.000s) [107.531660] [112/162] (894s left) kms_force_connector_basic (prune-stale-modes) [107.922369] Starting subtest: prune-stale-modes [108.668830] Subtest prune-stale-modes: SUCCESS (0.747s) [109.208770] [113/162] (893s left) kms_frontbuffer_tracking (basic) [109.486278] Subtest basic: SKIP (0.000s) [109.568093] [114/162] (892s left) kms_hdmi_inject (inject-audio) [109.630079] Starting subtest: inject-audio [110.262442] Subtest inject-audio: SUCCESS (0.630s) [110.529798] [115/162] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [110.809581] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [110.878964] [116/162] (891s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [111.167416] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [111.234360] [117/162] (891s left) kms_pipe_crc_basic (hang-read-crc) [111.511434] Subtest hang-read-crc: SKIP (0.000s) [111.580973] [118/162] (891s left) kms_pipe_crc_basic (nonblocking-crc) [111.856775] Subtest nonblocking-crc: SKIP (0.000s) [111.925295] [119/162] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [112.189352] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [112.260780] [120/162] (890s left) kms_pipe_crc_basic (read-crc) [112.528204] Subtest read-crc: SKIP (0.000s) [112.607350] [121/162] (890s left) kms_pipe_crc_basic (read-crc-frame-sequence) [112.872109] Subtest read-crc-frame-sequence: SKIP (0.000s) [112.944321] [122/162] (890s left) kms_pm_backlight (basic-brightness) [113.216184] Subtest basic-brightness: SKIP (0.000s) [113.285722] [123/162] (889s left) kms_pm_rpm (basic-pci-d3-state) [114.934858] Starting subtest: basic-pci-d3-state [115.248703] Subtest basic-pci-d3-state: SUCCESS (0.313s) [115.431376] [124/162] (887s left) kms_pm_rpm (basic-rte) [115.700995] Starting subtest: basic-rte [117.526125] Subtest basic-rte: SUCCESS (1.904s) [117.992488] [125/162] (885s left) kms_psr (psr-primary-page-flip) [118.475055] Subtest psr-primary-page-flip: SKIP (0.000s) [118.543835] [126/162] (884s left) kms_psr (psr-cursor-plane-move) [118.811234] Subtest psr-cursor-plane-move: SKIP (0.000s) [118.878489] [127/162] (884s left) kms_psr (psr-sprite-plane-onoff) [119.161221] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [119.230498] [128/162] (884s left) kms_psr (psr-primary-mmap-gtt) [119.502453] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [119.578590] [129/162] (883s left) kms_setmode (basic-clone-single-crtc) [119.636407] Starting subtest: basic-clone-single-crtc [119.639587] Subtest basic-clone-single-crtc: SKIP (0.000s) [119.699672] [130/162] (883s left) i915_pm_rps (basic-api) [119.773247] Starting subtest: basic-api [119.776915] Subtest basic-api: SUCCESS (0.005s) [119.860155] [131/162] (883s left) prime_self_import (basic-llseek-bad) [119.918261] Starting subtest: basic-llseek-bad [119.921343] Subtest basic-llseek-bad: SUCCESS (0.003s) [120.008301] [132/162] (883s left) prime_self_import (basic-llseek-size) [120.065102] Starting subtest: basic-llseek-size [120.068508] Subtest basic-llseek-size: SUCCESS (0.005s) [120.155215] [133/162] (883s left) prime_self_import (basic-with_fd_dup) [120.209237] Starting subtest: basic-with_fd_dup [120.214137] Subtest basic-with_fd_dup: SUCCESS (0.005s) [120.293151] [134/162] (883s left) prime_self_import (basic-with_one_bo) [120.349195] Starting subtest: basic-with_one_bo [120.353663] Subtest basic-with_one_bo: SUCCESS (0.006s) [120.418558] [135/162] (883s left) prime_self_import (basic-with_one_bo_two_files) [120.475205] Starting subtest: basic-with_one_bo_two_files [120.478689] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [120.567605] [136/162] (883s left) prime_self_import (basic-with_two_bos) [120.623225] Starting subtest: basic-with_two_bos [120.626676] Subtest basic-with_two_bos: SUCCESS (0.004s) [120.709853] [137/162] (883s left) prime_vgem (basic-fence-flip) [120.783470] Starting subtest: basic-fence-flip [121.006528] Subtest basic-fence-flip: SKIP (0.220s) [121.073406] [138/162] (882s left) prime_vgem (basic-fence-mmap) [121.146561] Starting subtest: basic-fence-mmap [121.179660] Subtest basic-fence-mmap: SUCCESS (0.034s) [121.272818] [139/162] (882s left) prime_vgem (basic-fence-read) [121.349560] Starting subtest: basic-fence-read [121.420156] Subtest basic-fence-read: SUCCESS (0.071s) [121.486247] [140/162] (882s left) prime_vgem (basic-gtt) [121.558490] Starting subtest: basic-gtt [121.575012] Subtest basic-gtt: SUCCESS (0.016s) [121.659093] [141/162] (882s left) prime_vgem (basic-read) [121.725656] Starting subtest: basic-read [121.759759] Subtest basic-read: SUCCESS (0.034s) [121.845497] [142/162] (882s left) prime_vgem (basic-write) [121.912501] Starting subtest: basic-write [121.950153] Subtest basic-write: SUCCESS (0.038s) [122.014503] [143/162] (882s left) vgem_basic (setversion) [122.075484] Starting subtest: setversion [122.077358] Subtest setversion: SUCCESS (0.000s) [122.132128] [144/162] (882s left) vgem_basic (create) [122.192639] Starting subtest: create [122.194123] Subtest create: SUCCESS (0.000s) [122.252495] [145/162] (882s left) vgem_basic (debugfs) [122.310431] Starting subtest: debugfs [122.311876] Subtest debugfs: SUCCESS (0.001s) [122.372795] [146/162] (882s left) vgem_basic (dmabuf-export) [122.432654] Starting subtest: dmabuf-export [122.434622] Subtest dmabuf-export: SUCCESS (0.003s) [122.511827] [147/162] (881s left) vgem_basic (dmabuf-fence) [122.573202] Starting subtest: dmabuf-fence [122.574216] Subtest dmabuf-fence: SUCCESS (0.001s) [122.634316] [148/162] (881s left) vgem_basic (dmabuf-fence-before) [122.700712] Starting subtest: dmabuf-fence-before [122.701766] Subtest dmabuf-fence-before: SUCCESS (0.000s) [122.758980] [149/162] (881s left) vgem_basic (dmabuf-mmap) [122.818782] Starting subtest: dmabuf-mmap [122.830256] Subtest dmabuf-mmap: SUCCESS (0.013s) [122.889291] [150/162] (881s left) vgem_basic (mmap) [122.950248] Starting subtest: mmap [122.959606] Subtest mmap: SUCCESS (0.012s) [123.021306] [151/162] (881s left) vgem_basic (second-client) [123.079447] Starting subtest: second-client [123.082794] Subtest second-client: SUCCESS (0.004s) [123.140889] [152/162] (881s left) vgem_basic (sysfs) [123.200366] Starting subtest: sysfs [123.201295] Subtest sysfs: SUCCESS (0.001s) [123.260383] [153/162] (881s left) core_hotunplug (unbind-rebind) [123.372066] Starting subtest: unbind-rebind [127.547521] Subtest unbind-rebind: SUCCESS (4.170s) [127.600685] [154/162] (877s left) vgem_basic (unload) [127.667243] Starting subtest: unload [156.669194] Subtest unload: SUCCESS (28.946s) [156.725800] [155/162] (848s left) i915_module_load (reload) [156.789284] Starting subtest: reload [160.437391] Subtest reload: SUCCESS (3.649s) [160.532552] [156/162] (844s left) gem_lmem_swapping (basic) [160.778414] Subtest basic: SKIP (0.000s) [160.886756] [157/162] (844s left) gem_lmem_swapping (parallel-random-engines) [160.950398] Subtest parallel-random-engines: SKIP (0.000s) [161.005103] [158/162] (844s left) gem_lmem_swapping (random-engines) [161.068781] Subtest random-engines: SKIP (0.000s) [161.124090] [159/162] (844s left) gem_lmem_swapping (verify-random) [161.189911] Subtest verify-random: SKIP (0.000s) [161.244361] [160/162] (844s left) i915_pm_rpm (module-reload) [164.270657] Starting subtest: module-reload [178.883695] Subtest module-reload: SUCCESS (14.588s) [178.927871] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [178.929364] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [178.932513] [161/162] (826s left) i915_selftest (live) [179.000449] Starting subtest: live [179.001609] Starting dynamic subtest: sanitycheck [181.816660] Dynamic subtest sanitycheck: SUCCESS (2.759s) [181.829876] Starting dynamic subtest: uncore [184.542268] Dynamic subtest uncore: SUCCESS (2.725s) [184.555369] Starting dynamic subtest: workarounds [187.653460] Dynamic subtest workarounds: SUCCESS (3.110s) [187.666639] Starting dynamic subtest: gt_engines [190.891128] Dynamic subtest gt_engines: SUCCESS (3.237s) [190.904218] Starting dynamic subtest: gt_timelines [206.762217] Dynamic subtest gt_timelines: SUCCESS (15.870s) [206.772503] Starting dynamic subtest: gt_contexts [209.709258] Dynamic subtest gt_contexts: SUCCESS (2.946s) [209.719588] Starting dynamic subtest: gt_lrc [215.634250] Dynamic subtest gt_lrc: SUCCESS (5.924s) [215.644666] Starting dynamic subtest: gt_mocs [218.453614] Dynamic subtest gt_mocs: SUCCESS (2.818s) [218.463907] Starting dynamic subtest: gt_pm [229.825390] Dynamic subtest gt_pm: SUCCESS (11.370s) [229.837723] Starting dynamic subtest: gt_heartbeat [232.569403] Dynamic subtest gt_heartbeat: SUCCESS (2.742s) [232.579862] Starting dynamic subtest: gt_tlb [236.970223] Dynamic subtest gt_tlb: SUCCESS (4.400s) [236.980524] Starting dynamic subtest: requests [247.130470] Dynamic subtest requests: SUCCESS (10.159s) [247.143249] Starting dynamic subtest: migrate [252.962154] Dynamic subtest migrate: SUCCESS (5.830s) [252.972601] Starting dynamic subtest: active [255.671359] Dynamic subtest active: SUCCESS (2.707s) [255.684709] Starting dynamic subtest: objects [259.402282] Dynamic subtest objects: SUCCESS (3.729s) [259.412637] Starting dynamic subtest: mman [265.834042] Dynamic subtest mman: SUCCESS (6.430s) [265.844559] Starting dynamic subtest: dmabuf [268.552067] Dynamic subtest dmabuf: SUCCESS (2.716s) [268.562401] Starting dynamic subtest: vma [271.230943] Dynamic subtest vma: SUCCESS (2.677s) [271.241342] Starting dynamic subtest: coherency [275.063253] Dynamic subtest coherency: SUCCESS (3.831s) [275.073586] Starting dynamic subtest: gtt [285.043515] Dynamic subtest gtt: SUCCESS (9.978s) [285.053940] Starting dynamic subtest: gem [288.277642] Dynamic subtest gem: SUCCESS (3.232s) [288.288113] Starting dynamic subtest: evict [293.138432] Dynamic subtest evict: SUCCESS (4.858s) [293.151277] Starting dynamic subtest: hugepages [302.263619] Dynamic subtest hugepages: SUCCESS (9.178s) [302.277556] Starting dynamic subtest: gem_contexts [322.117425] Dynamic subtest gem_contexts: SUCCESS (19.796s) [322.127925] Starting dynamic subtest: client [324.922366] Dynamic subtest client: SUCCESS (2.803s) [324.932723] Starting dynamic subtest: gem_migrate [327.614669] Dynamic subtest gem_migrate: SUCCESS (2.690s) [327.627940] Starting dynamic subtest: reset [330.727998] Dynamic subtest reset: SUCCESS (3.111s) [330.738561] Starting dynamic subtest: memory_region [333.492662] Dynamic subtest memory_region: SUCCESS (2.762s) [333.505780] Starting dynamic subtest: hangcheck [364.909353] Dynamic subtest hangcheck: SUCCESS (31.414s) [364.919773] Starting dynamic subtest: execlists [380.931818] Dynamic subtest execlists: SUCCESS (16.020s) [380.944559] Starting dynamic subtest: ring_submission [383.606226] Dynamic subtest ring_submission: SUCCESS (2.672s) [383.619548] Starting dynamic subtest: perf [386.382214] Dynamic subtest perf: SUCCESS (2.773s) [386.392653] Starting dynamic subtest: slpc [389.033680] Dynamic subtest slpc: SUCCESS (2.649s) [389.044140] Starting dynamic subtest: guc [391.689095] Dynamic subtest guc: SUCCESS (2.654s) [391.699518] Starting dynamic subtest: guc_multi_lrc [394.465438] Dynamic subtest guc_multi_lrc: SUCCESS (2.821s) [394.479534] Starting dynamic subtest: guc_hang [397.186405] Dynamic subtest guc_hang: SUCCESS (2.672s) [397.196910] Starting dynamic subtest: late_gt_pm [399.944524] Dynamic subtest late_gt_pm: SUCCESS (2.755s) [399.947043] Subtest live: SUCCESS (220.885s) [400.016237] [162/162] (605s left) dmabuf (all-tests) [400.082172] Starting subtest: all-tests [400.083595] Starting dynamic subtest: sanitycheck [400.158502] Dynamic subtest sanitycheck: SUCCESS (0.075s) [400.188693] Starting dynamic subtest: dma_fence [400.457823] Dynamic subtest dma_fence: SUCCESS (0.235s) [400.482230] Starting dynamic subtest: dma_fence_chain [400.486188] Dynamic subtest dma_fence_chain: SKIP (0.001s) [400.510872] Starting dynamic subtest: dma_fence_unwrap [400.513364] Dynamic subtest dma_fence_unwrap: SUCCESS (0.097s) [400.530941] Starting dynamic subtest: dma_resv [400.588033] Dynamic subtest dma_resv: SUCCESS (0.075s) [400.593899] Subtest all-tests: SUCCESS (0.508s) [400.656293] 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.