[30.210588] Initializing watchdogs [30.210667] /dev/watchdog0 [30.225645] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [30.235287] [001/162] (960s left) i915_module_load (load) [30.303165] Starting subtest: load [32.335621] Subtest load: SUCCESS (2.034s) [32.375048] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [32.376269] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [32.381262] [002/162] (958s left) core_auth (basic-auth) [32.446230] Starting subtest: basic-auth [32.449271] Subtest basic-auth: SUCCESS (0.001s) [32.487697] [003/162] (958s left) core_debugfs (read-all-entries) [32.537515] Starting subtest: read-all-entries [32.540688] Subtest read-all-entries: SUCCESS (0.002s) [32.578759] [004/162] (958s left) core_sysfs (read-all-entries) [32.630376] Starting subtest: read-all-entries [32.633503] Subtest read-all-entries: SUCCESS (0.003s) [32.671600] [005/162] (958s left) fbdev (eof) [32.728043] Subtest eof: SKIP (0.000s) [32.766132] [006/162] (958s left) fbdev (info) [32.819800] Subtest info: SKIP (0.000s) [32.861098] [007/162] (958s left) fbdev (nullptr) [32.917472] Subtest nullptr: SKIP (0.000s) [32.956052] [008/162] (958s left) fbdev (read) [33.010428] Subtest read: SKIP (0.000s) [33.048775] [009/162] (958s left) fbdev (write) [33.100820] Subtest write: SKIP (0.000s) [33.139466] [010/162] (957s left) gem_basic (bad-close) [33.200731] Starting subtest: bad-close [33.207060] Subtest bad-close: SUCCESS (0.000s) [33.247111] [011/162] (957s left) gem_basic (create-close) [33.294754] Starting subtest: create-close [33.301560] Subtest create-close: SUCCESS (0.000s) [33.352852] [012/162] (957s left) gem_basic (create-fd-close) [33.404661] Starting subtest: create-fd-close [33.410455] Subtest create-fd-close: SUCCESS (0.000s) [33.455626] [013/162] (957s left) gem_busy (busy@all-engines) [33.516763] Starting subtest: busy [33.520030] Starting dynamic subtest: all-engines [33.544027] Dynamic subtest all-engines: SUCCESS (0.027s) [33.547276] Subtest busy: SUCCESS (0.027s) [33.860218] [014/162] (957s left) gem_close_race (basic-process) [33.925304] Starting subtest: basic-process [33.982779] Subtest basic-process: SUCCESS (0.060s) [34.126212] [015/162] (957s left) gem_close_race (basic-threads) [34.184900] Starting subtest: basic-threads [35.365563] Subtest basic-threads: SUCCESS (1.181s) [35.518700] [016/162] (955s left) gem_ctx_create (basic) [35.574970] Starting subtest: basic [35.578191] Subtest basic: SUCCESS (0.000s) [35.726715] [017/162] (955s left) gem_ctx_create (basic-files) [35.782135] Starting subtest: basic-files [37.797302] Subtest basic-files: SUCCESS (2.010s) [37.967977] [018/162] (953s left) gem_ctx_exec (basic) [38.020090] Starting subtest: basic [38.023154] Subtest basic: SUCCESS (0.004s) [38.097586] [019/162] (953s left) gem_exec_basic (basic) [38.154163] Starting subtest: basic [38.157161] Starting dynamic subtest: rcs0-smem [38.160147] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [38.170347] Starting dynamic subtest: bcs0-smem [38.173550] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [38.183686] Starting dynamic subtest: vcs0-smem [38.186800] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [38.196632] Starting dynamic subtest: vecs0-smem [38.199656] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [38.202673] Subtest basic: SUCCESS (0.007s) [38.342294] [020/162] (953s left) gem_exec_create (basic) [38.399058] Starting subtest: basic [38.402141] Starting dynamic subtest: smem [40.438708] Dynamic subtest smem: SUCCESS (2.040s) [40.442126] Subtest basic: SUCCESS (2.040s) [40.589044] [021/162] (950s left) gem_exec_fence (basic-busy) [40.774381] Starting subtest: basic-busy [40.777504] Starting dynamic subtest: rcs0 [40.796211] Dynamic subtest rcs0: SUCCESS (0.032s) [40.807549] Starting dynamic subtest: bcs0 [40.829704] Dynamic subtest bcs0: SUCCESS (0.033s) [40.845991] Starting dynamic subtest: vcs0 [40.866587] Dynamic subtest vcs0: SUCCESS (0.037s) [40.877665] Starting dynamic subtest: vecs0 [40.890599] Dynamic subtest vecs0: SUCCESS (0.024s) [40.893981] Subtest basic-busy: SUCCESS (0.126s) [41.405146] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [41.409327] [022/162] (950s left) gem_exec_fence (basic-wait) [41.584808] Starting subtest: basic-wait [41.588191] Starting dynamic subtest: rcs0 [41.610343] Dynamic subtest rcs0: SUCCESS (0.029s) [41.623795] Starting dynamic subtest: bcs0 [41.642201] Dynamic subtest bcs0: SUCCESS (0.032s) [41.653856] Starting dynamic subtest: vcs0 [41.672075] Dynamic subtest vcs0: SUCCESS (0.030s) [41.683335] Starting dynamic subtest: vecs0 [41.700202] Dynamic subtest vecs0: SUCCESS (0.028s) [41.703501] Subtest basic-wait: SUCCESS (0.119s) [42.183817] [023/162] (949s left) gem_exec_fence (basic-await) [42.355974] Starting subtest: basic-await [42.359156] Starting dynamic subtest: rcs0 [42.433773] Dynamic subtest rcs0: SUCCESS (0.077s) [42.451991] Starting dynamic subtest: bcs0 [42.522751] Dynamic subtest bcs0: SUCCESS (0.088s) [42.543862] Starting dynamic subtest: vcs0 [42.612655] Dynamic subtest vcs0: SUCCESS (0.089s) [42.634396] Starting dynamic subtest: vecs0 [42.704588] Dynamic subtest vecs0: SUCCESS (0.092s) [42.708122] Subtest basic-await: SUCCESS (0.349s) [43.182957] [024/162] (948s left) gem_exec_fence (nb-await) [43.356728] Starting subtest: nb-await [43.359669] Starting dynamic subtest: rcs0 [43.420381] Dynamic subtest rcs0: SUCCESS (0.063s) [43.442263] Starting dynamic subtest: bcs0 [43.486332] Dynamic subtest bcs0: SUCCESS (0.066s) [43.508514] Starting dynamic subtest: vcs0 [43.550285] Dynamic subtest vcs0: SUCCESS (0.063s) [43.572701] Starting dynamic subtest: vecs0 [43.614707] Dynamic subtest vecs0: SUCCESS (0.064s) [43.618163] Subtest nb-await: SUCCESS (0.258s) [44.090101] [025/162] (947s left) gem_exec_gttfill (basic) [44.149592] Starting subtest: basic [47.499938] Subtest basic: SUCCESS (3.381s) [47.664378] [026/162] (944s left) gem_exec_parallel (engines) [47.792843] Starting subtest: engines [47.795829] Starting dynamic subtest: basic [49.493628] Dynamic subtest basic: SUCCESS (1.736s) [49.505034] Starting dynamic subtest: contexts [51.509406] Dynamic subtest contexts: SUCCESS (2.048s) [51.520871] Starting dynamic subtest: fds [53.565623] Dynamic subtest fds: SUCCESS (2.082s) [53.578308] Starting dynamic subtest: userptr [145.769652] Inactivity timeout exceeded. Killing the current test with SIGQUIT. [147.289811] Warning: kernel log ringbuffer underflow, some records lost. [264.270892] Timeout. Killing the current test with SIGKILL. [264.353372] Closing watchdogs [264.360751] Initializing watchdogs [264.360829] /dev/watchdog0 [264.382121] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [264.391953] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [264.393226] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [264.393935] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [264.401749] [027/162] (727s left) gem_exec_store (basic) [264.483797] Starting subtest: basic [264.547872] Subtest basic: SUCCESS (0.066s) [264.710808] [028/162] (727s left) gem_flink_basic (bad-flink) [264.760757] Starting subtest: bad-flink [264.763823] Subtest bad-flink: SUCCESS (0.000s) [264.808509] [029/162] (727s left) gem_flink_basic (bad-open) [264.858272] Starting subtest: bad-open [264.861417] Subtest bad-open: SUCCESS (0.000s) [264.905730] [030/162] (727s left) gem_flink_basic (basic) [264.955855] Starting subtest: basic [264.959054] Subtest basic: SUCCESS (0.000s) [265.028364] [031/162] (727s left) gem_flink_basic (double-flink) [265.077302] Starting subtest: double-flink [265.080451] Subtest double-flink: SUCCESS (0.000s) [265.138537] [032/162] (726s left) gem_flink_basic (flink-lifetime) [265.188681] Starting subtest: flink-lifetime [265.191852] Subtest flink-lifetime: SUCCESS (0.001s) [265.249956] [033/162] (726s left) gem_huc_copy (huc-copy) [265.302238] Starting subtest: huc-copy [265.308549] Subtest huc-copy: SKIP (0.000s) [265.385584] [034/162] (726s left) gem_linear_blits (basic) [265.561507] Starting subtest: basic [265.569787] Subtest basic: SUCCESS (0.009s) [265.664622] [035/162] (726s left) gem_mmap (basic) [265.793479] Starting subtest: basic [265.809341] Subtest basic: SUCCESS (0.000s) [265.858316] [036/162] (726s left) gem_mmap_gtt (basic) [265.909840] Starting subtest: basic [265.924183] Subtest basic: SUCCESS (0.001s) [266.038996] [037/162] (726s left) gem_render_linear_blits (basic) [266.524339] Starting subtest: basic [266.883071] Subtest basic: SUCCESS (0.125s) [267.419235] [038/162] (725s left) gem_render_tiled_blits (basic) [267.487217] Starting subtest: basic [267.520713] Subtest basic: SUCCESS (0.030s) [267.577483] [039/162] (725s left) gem_ringfill (basic-all) [267.818144] Starting subtest: basic-all [268.949892] Subtest basic-all: SUCCESS (1.132s) [269.043384] [040/162] (724s left) gem_softpin (allocator-basic) [269.099319] Starting subtest: allocator-basic [269.196097] Subtest allocator-basic: SUCCESS (0.094s) [269.280657] [041/162] (723s left) gem_softpin (allocator-basic-reserve) [269.336698] Starting subtest: allocator-basic-reserve [269.429595] Subtest allocator-basic-reserve: SUCCESS (0.096s) [269.517497] [042/162] (723s left) gem_softpin (safe-alignment) [269.572688] Starting subtest: safe-alignment [269.583900] Subtest safe-alignment: SUCCESS (0.011s) [269.662879] [043/162] (723s left) gem_sync (basic-all) [269.744169] Starting subtest: basic-all [271.804595] Subtest basic-all: SUCCESS (2.080s) [271.954455] [044/162] (721s left) gem_sync (basic-each) [272.034185] Starting subtest: basic-each [274.159727] Subtest basic-each: SUCCESS (2.145s) [274.319570] [045/162] (718s left) gem_tiled_blits (basic) [274.430720] Starting subtest: basic [274.444857] Subtest basic: SUCCESS (0.014s) [274.536655] [046/162] (718s left) gem_tiled_fence_blits (basic) [274.730420] Starting subtest: basic [274.739137] Subtest basic: SUCCESS (0.008s) [274.828071] [047/162] (718s left) gem_tiled_pread_basic (basic) [274.957526] Starting subtest: basic [275.087312] Subtest basic: SUCCESS (0.133s) [275.158123] [048/162] (718s left) gem_wait (busy@all-engines) [275.219647] Starting subtest: busy [275.222847] Starting dynamic subtest: all-engines [275.745211] Dynamic subtest all-engines: SUCCESS (0.524s) [275.748326] Subtest busy: SUCCESS (0.525s) [275.907243] [049/162] (717s left) gem_wait (wait@all-engines) [275.968609] Starting subtest: wait [275.971705] Starting dynamic subtest: all-engines [277.002414] Dynamic subtest all-engines: SUCCESS (1.033s) [277.006264] Subtest wait: SUCCESS (1.034s) [277.163170] [050/162] (716s left) i915_getparams_basic (basic-eu-total) [277.212496] Starting subtest: basic-eu-total [277.218724] Subtest basic-eu-total: SUCCESS (0.000s) [277.263936] [051/162] (716s left) i915_getparams_basic (basic-subslice-total) [277.312695] Starting subtest: basic-subslice-total [277.319050] Subtest basic-subslice-total: SUCCESS (0.000s) [277.364527] [052/162] (716s left) i915_hangman (error-state-basic) [277.421433] Starting subtest: error-state-basic [277.429256] Subtest error-state-basic: SUCCESS (0.006s) [277.504897] [053/162] (716s left) i915_pciid [277.606420] [054/162] (716s left) intel_hwmon (hwmon-read) [277.664140] Subtest hwmon-read: SKIP (0.000s) [277.709433] [055/162] (716s left) intel_hwmon (hwmon-write) [277.761618] Subtest hwmon-write: SKIP (0.000s) [277.806403] [056/162] (716s left) kms_addfb_basic (addfb25-4-tiled) [277.904606] Starting subtest: addfb25-4-tiled [277.907952] Subtest addfb25-4-tiled: SUCCESS (0.000s) [277.974400] [057/162] (715s left) kms_addfb_basic (addfb25-bad-modifier) [278.060511] Starting subtest: addfb25-bad-modifier [278.063631] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [278.135702] [058/162] (715s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [278.216889] Starting subtest: addfb25-framebuffer-vs-set-tiling [278.220207] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [278.277480] [059/162] (715s left) kms_addfb_basic (addfb25-modifier-no-flag) [278.358815] Starting subtest: addfb25-modifier-no-flag [278.362154] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [278.423890] [060/162] (715s left) kms_addfb_basic (addfb25-x-tiled-legacy) [278.506518] Starting subtest: addfb25-x-tiled-legacy [278.509488] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [278.571442] [061/162] (715s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [278.650393] Starting subtest: addfb25-x-tiled-mismatch-legacy [278.653483] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [278.729138] [062/162] (715s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [278.809162] Starting subtest: addfb25-yf-tiled-legacy [278.812149] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [278.874697] [063/162] (715s left) kms_addfb_basic (addfb25-y-tiled-legacy) [278.958161] Starting subtest: addfb25-y-tiled-legacy [278.961564] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [279.020933] [064/162] (715s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [279.101476] Starting subtest: addfb25-y-tiled-small-legacy [279.104479] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [279.166038] [065/162] (715s left) kms_addfb_basic (bad-pitch-0) [279.217288] Starting subtest: bad-pitch-0 [279.221902] Subtest bad-pitch-0: SUCCESS (0.000s) [279.309975] [066/162] (714s left) kms_addfb_basic (bad-pitch-1024) [279.366469] Starting subtest: bad-pitch-1024 [279.369762] Subtest bad-pitch-1024: SUCCESS (0.000s) [279.454673] [067/162] (714s left) kms_addfb_basic (bad-pitch-128) [279.509538] Starting subtest: bad-pitch-128 [279.514272] Subtest bad-pitch-128: SUCCESS (0.000s) [279.596650] [068/162] (714s left) kms_addfb_basic (bad-pitch-256) [279.648366] Starting subtest: bad-pitch-256 [279.652875] Subtest bad-pitch-256: SUCCESS (0.000s) [279.741691] [069/162] (714s left) kms_addfb_basic (bad-pitch-32) [279.792614] Starting subtest: bad-pitch-32 [279.796660] Subtest bad-pitch-32: SUCCESS (0.000s) [279.887804] [070/162] (714s left) kms_addfb_basic (bad-pitch-63) [279.938872] Starting subtest: bad-pitch-63 [279.943512] Subtest bad-pitch-63: SUCCESS (0.000s) [280.034808] [071/162] (714s left) kms_addfb_basic (bad-pitch-65536) [280.086796] Starting subtest: bad-pitch-65536 [280.091089] Subtest bad-pitch-65536: SUCCESS (0.000s) [280.184083] [072/162] (714s left) kms_addfb_basic (bad-pitch-999) [280.236327] Starting subtest: bad-pitch-999 [280.239711] Subtest bad-pitch-999: SUCCESS (0.000s) [280.347363] [073/162] (714s left) kms_addfb_basic (basic) [280.398812] Starting subtest: basic [280.402829] Subtest basic: SUCCESS (0.000s) [280.489657] [074/162] (714s left) kms_addfb_basic (basic-x-tiled-legacy) [280.541193] Starting subtest: basic-x-tiled-legacy [280.546210] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [280.635710] [075/162] (714s left) kms_addfb_basic (basic-y-tiled-legacy) [280.691133] Starting subtest: basic-y-tiled-legacy [280.694213] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [280.778819] [076/162] (714s left) kms_addfb_basic (bo-too-small) [280.855116] Starting subtest: bo-too-small [280.858124] Subtest bo-too-small: SUCCESS (0.000s) [280.919903] [077/162] (713s left) kms_addfb_basic (bo-too-small-due-to-tiling) [281.000554] Starting subtest: bo-too-small-due-to-tiling [281.003653] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [281.067368] [078/162] (713s left) kms_addfb_basic (clobberred-modifier) [281.128088] Starting subtest: clobberred-modifier [281.130917] Subtest clobberred-modifier: SUCCESS (0.000s) [281.218711] [079/162] (713s left) kms_addfb_basic (framebuffer-vs-set-tiling) [281.271391] Starting subtest: framebuffer-vs-set-tiling [281.274976] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [281.359093] [080/162] (713s left) kms_addfb_basic (invalid-get-prop) [281.410554] Starting subtest: invalid-get-prop [281.415127] Subtest invalid-get-prop: SUCCESS (0.000s) [281.510560] [081/162] (713s left) kms_addfb_basic (invalid-get-prop-any) [281.562697] Starting subtest: invalid-get-prop-any [281.567234] Subtest invalid-get-prop-any: SUCCESS (0.000s) [281.654647] [082/162] (713s left) kms_addfb_basic (invalid-set-prop) [281.706217] Starting subtest: invalid-set-prop [281.710448] Subtest invalid-set-prop: SUCCESS (0.000s) [281.800079] [083/162] (713s left) kms_addfb_basic (invalid-set-prop-any) [281.851346] Starting subtest: invalid-set-prop-any [281.855577] Subtest invalid-set-prop-any: SUCCESS (0.000s) [281.944672] [084/162] (713s left) kms_addfb_basic (no-handle) [281.995129] Starting subtest: no-handle [281.999329] Subtest no-handle: SUCCESS (0.000s) [282.086347] [085/162] (713s left) kms_addfb_basic (size-max) [282.165094] Starting subtest: size-max [282.168264] Subtest size-max: SUCCESS (0.000s) [282.231731] [086/162] (713s left) kms_addfb_basic (small-bo) [282.316530] Starting subtest: small-bo [282.319768] Subtest small-bo: SUCCESS (0.000s) [282.372428] [087/162] (712s left) kms_addfb_basic (tile-pitch-mismatch) [282.423974] Starting subtest: tile-pitch-mismatch [282.428243] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [282.514802] [088/162] (712s left) kms_addfb_basic (too-high) [282.593594] Starting subtest: too-high [282.596584] Subtest too-high: SUCCESS (0.001s) [282.662765] [089/162] (712s left) kms_addfb_basic (too-wide) [282.744584] Starting subtest: too-wide [282.747602] Subtest too-wide: SUCCESS (0.000s) [282.795871] [090/162] (712s left) kms_addfb_basic (unused-handle) [282.849334] Starting subtest: unused-handle [282.852575] Subtest unused-handle: SUCCESS (0.000s) [282.940805] [091/162] (712s left) kms_addfb_basic (unused-modifier) [282.991692] Starting subtest: unused-modifier [282.995540] Subtest unused-modifier: SUCCESS (0.000s) [283.081717] [092/162] (712s left) kms_addfb_basic (unused-offsets) [283.132743] Starting subtest: unused-offsets [283.136696] Subtest unused-offsets: SUCCESS (0.000s) [283.221653] [093/162] (712s left) kms_addfb_basic (unused-pitches) [283.271207] Starting subtest: unused-pitches [283.275160] Subtest unused-pitches: SUCCESS (0.000s) [283.368599] [094/162] (712s left) kms_busy (basic) [283.453288] Subtest basic: SKIP (0.000s) [283.498523] [095/162] (712s left) kms_prop_blob (basic) [283.549993] Starting subtest: basic [283.553251] Subtest basic: SUCCESS (0.000s) [283.598146] [096/162] (712s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [283.702910] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [283.750840] [097/162] (712s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [283.854327] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [283.998248] [098/162] (711s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [284.833540] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [285.376459] [099/162] (710s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [285.483615] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [285.531791] [100/162] (710s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [285.636445] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [285.687586] [101/162] (710s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [285.787586] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [285.835196] [102/162] (710s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [285.940197] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [285.986858] [103/162] (710s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [286.090406] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [286.138340] [104/162] (710s left) kms_dsc (dsc-basic) [286.218702] Subtest dsc-basic: SKIP (0.000s) [286.263971] [105/162] (710s left) kms_flip (basic-flip-vs-dpms) [286.349165] Starting subtest: basic-flip-vs-dpms [286.355620] Subtest basic-flip-vs-dpms: SKIP (0.001s) [286.418196] [106/162] (710s left) kms_flip (basic-flip-vs-modeset) [286.498561] Starting subtest: basic-flip-vs-modeset [286.504432] Subtest basic-flip-vs-modeset: SKIP (0.001s) [286.550567] [107/162] (710s left) kms_flip (basic-flip-vs-wf_vblank) [286.632485] Starting subtest: basic-flip-vs-wf_vblank [286.638589] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [286.683520] [108/162] (710s left) kms_flip (basic-plain-flip) [286.765325] Starting subtest: basic-plain-flip [286.771497] Subtest basic-plain-flip: SKIP (0.001s) [286.836230] [109/162] (709s left) kms_force_connector_basic (force-connector-state) [286.991021] Starting subtest: force-connector-state [287.066805] Subtest force-connector-state: SUCCESS (0.079s) [287.233638] [110/162] (709s left) kms_force_connector_basic (force-edid) [287.387615] Starting subtest: force-edid [287.562902] Subtest force-edid: SUCCESS (0.179s) [287.653760] [111/162] (709s left) kms_force_connector_basic (force-load-detect) [287.801378] Starting subtest: force-load-detect [287.808158] Subtest force-load-detect: SKIP (0.000s) [287.873488] [112/162] (709s left) kms_force_connector_basic (prune-stale-modes) [288.032817] Starting subtest: prune-stale-modes [288.201529] Subtest prune-stale-modes: SUCCESS (0.175s) [288.286734] [113/162] (708s left) kms_frontbuffer_tracking (basic) [288.370888] Subtest basic: SKIP (0.000s) [288.430275] [114/162] (708s left) kms_hdmi_inject (inject-audio) [288.486373] Starting subtest: inject-audio [288.492689] Subtest inject-audio: SKIP (0.000s) [288.543636] [115/162] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [288.624752] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [288.670664] [116/162] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [288.751531] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [288.798828] [117/162] (708s left) kms_pipe_crc_basic (hang-read-crc) [288.879730] Subtest hang-read-crc: SKIP (0.000s) [288.925385] [118/162] (708s left) kms_pipe_crc_basic (nonblocking-crc) [289.003985] Subtest nonblocking-crc: SKIP (0.000s) [289.049381] [119/162] (708s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [289.129964] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [289.175482] [120/162] (708s left) kms_pipe_crc_basic (read-crc) [289.255415] Subtest read-crc: SKIP (0.000s) [289.300816] [121/162] (708s left) kms_pipe_crc_basic (read-crc-frame-sequence) [289.382025] Subtest read-crc-frame-sequence: SKIP (0.000s) [289.426958] [122/162] (707s left) kms_pm_backlight (basic-brightness) [289.512763] Subtest basic-brightness: SKIP (0.000s) [289.558472] [123/162] (707s left) kms_pm_rpm (basic-pci-d3-state) [300.878787] Starting subtest: basic-pci-d3-state [301.062947] Subtest basic-pci-d3-state: SUCCESS (0.187s) [301.120783] [124/162] (696s left) kms_pm_rpm (basic-rte) [301.170494] Starting subtest: basic-rte [312.703127] Subtest basic-rte: SUCCESS (11.539s) [313.015852] [125/162] (684s left) kms_psr (psr-primary-page-flip) [313.097305] Subtest psr-primary-page-flip: SKIP (0.000s) [313.143722] [126/162] (684s left) kms_psr (psr-cursor-plane-move) [313.228193] Subtest psr-cursor-plane-move: SKIP (0.000s) [313.274596] [127/162] (684s left) kms_psr (psr-sprite-plane-onoff) [313.355924] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [313.402456] [128/162] (684s left) kms_psr (psr-primary-mmap-gtt) [313.487165] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [313.532661] [129/162] (684s left) kms_setmode (basic-clone-single-crtc) [313.588180] Starting subtest: basic-clone-single-crtc [313.597587] Subtest basic-clone-single-crtc: SKIP (0.000s) [313.647142] [130/162] (684s left) i915_pm_rps (basic-api) [313.702968] Starting subtest: basic-api [313.706151] Subtest basic-api: SUCCESS (0.003s) [313.754342] [131/162] (684s left) prime_self_import (basic-llseek-bad) [313.807109] Starting subtest: basic-llseek-bad [313.813486] Subtest basic-llseek-bad: SUCCESS (0.002s) [313.878993] [132/162] (683s left) prime_self_import (basic-llseek-size) [313.925924] Starting subtest: basic-llseek-size [313.932742] Subtest basic-llseek-size: SUCCESS (0.003s) [313.994726] [133/162] (683s left) prime_self_import (basic-with_fd_dup) [314.041416] Starting subtest: basic-with_fd_dup [314.047892] Subtest basic-with_fd_dup: SUCCESS (0.002s) [314.110678] [134/162] (683s left) prime_self_import (basic-with_one_bo) [314.160665] Starting subtest: basic-with_one_bo [314.166857] Subtest basic-with_one_bo: SUCCESS (0.003s) [314.213813] [135/162] (683s left) prime_self_import (basic-with_one_bo_two_files) [314.262186] Starting subtest: basic-with_one_bo_two_files [314.268246] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [314.335659] [136/162] (683s left) prime_self_import (basic-with_two_bos) [314.382982] Starting subtest: basic-with_two_bos [314.389351] Subtest basic-with_two_bos: SUCCESS (0.003s) [314.450298] [137/162] (683s left) prime_vgem (basic-fence-flip) [314.508233] Starting subtest: basic-fence-flip [314.566836] Subtest basic-fence-flip: SKIP (0.059s) [314.615769] [138/162] (683s left) prime_vgem (basic-fence-mmap) [314.674063] Starting subtest: basic-fence-mmap [314.690114] Subtest basic-fence-mmap: SUCCESS (0.024s) [314.761286] [139/162] (683s left) prime_vgem (basic-fence-read) [314.818674] Starting subtest: basic-fence-read [314.865194] Subtest basic-fence-read: SUCCESS (0.047s) [314.936887] [140/162] (683s left) prime_vgem (basic-gtt) [314.992171] Starting subtest: basic-gtt [315.000791] Subtest basic-gtt: SUCCESS (0.012s) [315.075053] [141/162] (683s left) prime_vgem (basic-read) [315.129853] Starting subtest: basic-read [315.148190] Subtest basic-read: SUCCESS (0.022s) [315.232537] [142/162] (683s left) prime_vgem (basic-write) [315.293809] Starting subtest: basic-write [315.312156] Subtest basic-write: SUCCESS (0.022s) [315.366269] [143/162] (683s left) vgem_basic (setversion) [315.422179] Starting subtest: setversion [315.428617] Subtest setversion: SUCCESS (0.000s) [315.477770] [144/162] (682s left) vgem_basic (create) [315.529574] Starting subtest: create [315.533027] Subtest create: SUCCESS (0.000s) [315.582471] [145/162] (682s left) vgem_basic (debugfs) [315.635178] Starting subtest: debugfs [315.638854] Subtest debugfs: SUCCESS (0.000s) [315.688985] [146/162] (682s left) vgem_basic (dmabuf-export) [315.740196] Starting subtest: dmabuf-export [315.746754] Subtest dmabuf-export: SUCCESS (0.002s) [315.810074] [147/162] (682s left) vgem_basic (dmabuf-fence) [315.863631] Starting subtest: dmabuf-fence [315.866763] Subtest dmabuf-fence: SUCCESS (0.001s) [315.918426] [148/162] (682s left) vgem_basic (dmabuf-fence-before) [315.969270] Starting subtest: dmabuf-fence-before [315.972394] Subtest dmabuf-fence-before: SUCCESS (0.000s) [316.019767] [149/162] (682s left) vgem_basic (dmabuf-mmap) [316.071939] Starting subtest: dmabuf-mmap [316.075116] Subtest dmabuf-mmap: SUCCESS (0.009s) [316.121702] [150/162] (682s left) vgem_basic (mmap) [316.172471] Starting subtest: mmap [316.175634] Subtest mmap: SUCCESS (0.006s) [316.222842] [151/162] (682s left) vgem_basic (second-client) [316.277306] Starting subtest: second-client [316.283908] Subtest second-client: SUCCESS (0.002s) [316.335537] [152/162] (682s left) vgem_basic (sysfs) [316.415977] Starting subtest: sysfs [316.419154] Subtest sysfs: SUCCESS (0.000s) [316.538227] [153/162] (682s left) core_hotunplug (unbind-rebind) [317.941224] Starting subtest: unbind-rebind [321.211420] Subtest unbind-rebind: SUCCESS (3.480s) [321.258412] [154/162] (677s left) vgem_basic (unload) [321.311679] Starting subtest: unload [350.140149] Subtest unload: SUCCESS (28.832s) [350.206956] [155/162] (648s left) i915_module_load (reload) [350.258674] Starting subtest: reload [352.758748] Subtest reload: SUCCESS (2.503s) [352.805542] [156/162] (646s left) gem_lmem_swapping (basic) [352.864478] Subtest basic: SKIP (0.000s) [352.909250] [157/162] (646s left) gem_lmem_swapping (parallel-random-engines) [352.958503] Subtest parallel-random-engines: SKIP (0.000s) [353.003576] [158/162] (646s left) gem_lmem_swapping (random-engines) [353.057939] Subtest random-engines: SKIP (0.000s) [353.102229] [159/162] (646s left) gem_lmem_swapping (verify-random) [353.155041] Subtest verify-random: SKIP (0.000s) [353.200614] [160/162] (646s left) i915_pm_rpm (module-reload) [364.524602] Starting subtest: module-reload [392.289791] Subtest module-reload: SUCCESS (27.771s) [392.322166] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [392.323270] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [392.327790] [161/162] (607s left) i915_selftest (live) [392.380943] Starting subtest: live [392.384188] Starting dynamic subtest: sanitycheck [394.607992] Dynamic subtest sanitycheck: SUCCESS (2.195s) [394.672457] Starting dynamic subtest: uncore [396.817836] Dynamic subtest uncore: SUCCESS (2.234s) [396.830665] Starting dynamic subtest: workarounds [399.229339] Dynamic subtest workarounds: SUCCESS (2.412s) [399.247261] Starting dynamic subtest: gt_engines [401.839943] Dynamic subtest gt_engines: SUCCESS (2.616s) [401.851749] Starting dynamic subtest: gt_timelines [410.944064] Dynamic subtest gt_timelines: SUCCESS (9.103s) [410.955550] Starting dynamic subtest: gt_contexts [413.232683] Dynamic subtest gt_contexts: SUCCESS (2.288s) [413.244401] Starting dynamic subtest: gt_lrc [417.831298] Dynamic subtest gt_lrc: SUCCESS (4.596s) [417.844332] Starting dynamic subtest: gt_mocs [420.108412] Dynamic subtest gt_mocs: SUCCESS (2.269s) [420.122330] Starting dynamic subtest: gt_pm [426.594704] Dynamic subtest gt_pm: SUCCESS (6.494s) [426.606561] Starting dynamic subtest: gt_heartbeat [428.763811] Dynamic subtest gt_heartbeat: SUCCESS (2.168s) [428.775344] Starting dynamic subtest: gt_tlb [432.153689] Dynamic subtest gt_tlb: SUCCESS (3.389s) [432.165870] Starting dynamic subtest: requests [440.718315] Dynamic subtest requests: SUCCESS (8.562s) [440.730056] Starting dynamic subtest: migrate [445.912720] Dynamic subtest migrate: SUCCESS (5.195s) [445.924085] Starting dynamic subtest: active [448.068218] Dynamic subtest active: SUCCESS (2.147s) [448.079591] Starting dynamic subtest: objects [450.760854] Dynamic subtest objects: SUCCESS (2.699s) [450.772658] Starting dynamic subtest: mman [456.071466] Dynamic subtest mman: SUCCESS (5.308s) [456.084275] Starting dynamic subtest: dmabuf [458.328193] Dynamic subtest dmabuf: SUCCESS (2.256s) [458.341130] Starting dynamic subtest: vma [460.627990] Dynamic subtest vma: SUCCESS (2.298s) [460.642462] Starting dynamic subtest: coherency [463.628226] Dynamic subtest coherency: SUCCESS (2.996s) [463.639842] Starting dynamic subtest: gtt [473.113707] Dynamic subtest gtt: SUCCESS (9.490s) [473.125562] Starting dynamic subtest: gem [475.448191] Dynamic subtest gem: SUCCESS (2.328s) [475.459679] Starting dynamic subtest: evict [478.756756] Dynamic subtest evict: SUCCESS (3.313s) [478.768862] Starting dynamic subtest: hugepages [487.490993] Dynamic subtest hugepages: SUCCESS (8.733s) [487.502864] Starting dynamic subtest: gem_contexts [502.267494] Dynamic subtest gem_contexts: SUCCESS (14.776s) [502.279653] Starting dynamic subtest: client [504.468562] Dynamic subtest client: SUCCESS (2.192s) [504.479998] Starting dynamic subtest: gem_migrate [506.638454] Dynamic subtest gem_migrate: SUCCESS (2.173s) [506.650437] Starting dynamic subtest: reset [509.018120] Dynamic subtest reset: SUCCESS (2.381s) [509.033137] Starting dynamic subtest: memory_region [511.168258] Dynamic subtest memory_region: SUCCESS (2.145s) [511.179683] Starting dynamic subtest: hangcheck [536.410747] Dynamic subtest hangcheck: SUCCESS (25.247s) [536.422544] Starting dynamic subtest: execlists [546.847100] Dynamic subtest execlists: SUCCESS (10.435s) [546.858732] Starting dynamic subtest: ring_submission [548.977246] Dynamic subtest ring_submission: SUCCESS (2.128s) [548.989182] Starting dynamic subtest: perf [551.236468] Dynamic subtest perf: SUCCESS (2.257s) [551.250195] Starting dynamic subtest: slpc [553.386636] Dynamic subtest slpc: SUCCESS (2.151s) [553.398624] Starting dynamic subtest: guc [555.518337] Dynamic subtest guc: SUCCESS (2.130s) [555.529954] Starting dynamic subtest: guc_multi_lrc [557.658470] Dynamic subtest guc_multi_lrc: SUCCESS (2.138s) [557.670660] Starting dynamic subtest: guc_hang [559.829323] Dynamic subtest guc_hang: SUCCESS (2.170s) [559.842161] Starting dynamic subtest: late_gt_pm [562.018581] Dynamic subtest late_gt_pm: SUCCESS (2.182s) [562.021793] Subtest live: SUCCESS (169.632s) [562.059185] [162/162] (437s left) dmabuf (all-tests) [562.115306] Starting subtest: all-tests [562.118565] Starting dynamic subtest: sanitycheck [562.178974] Dynamic subtest sanitycheck: SUCCESS (0.064s) [562.194068] Starting dynamic subtest: dma_fence [562.355464] Dynamic subtest dma_fence: SUCCESS (0.174s) [562.371054] Starting dynamic subtest: dma_fence_chain [573.457027] Dynamic subtest dma_fence_chain: SUCCESS (11.100s) [573.472788] Starting dynamic subtest: dma_fence_unwrap [573.523936] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [573.537809] Starting dynamic subtest: dma_resv [573.590519] Dynamic subtest dma_resv: SUCCESS (0.063s) [573.595297] Subtest all-tests: SUCCESS (11.477s) [573.631436] 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.