[86.358852] Initializing watchdogs [86.359367] /dev/watchdog0 [86.442882] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [86.466968] [001/162] (960s left) i915_module_load (load) [87.607568] Starting subtest: load [93.316351] Subtest load: SUCCESS (5.713s) [93.647405] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [93.657734] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [93.668093] [002/162] (953s left) core_auth (basic-auth) [93.928350] Starting subtest: basic-auth [93.942515] Subtest basic-auth: SUCCESS (0.005s) [94.172186] [003/162] (953s left) core_debugfs (read-all-entries) [94.397443] Starting subtest: read-all-entries [94.408512] Subtest read-all-entries: SUCCESS (0.011s) [94.595698] [004/162] (953s left) core_sysfs (read-all-entries) [94.828871] Starting subtest: read-all-entries [94.847412] Subtest read-all-entries: SUCCESS (0.018s) [95.030576] [005/162] (952s left) fbdev (eof) [95.307100] Subtest eof: SKIP (0.000s) [95.467595] [006/162] (952s left) fbdev (info) [95.745162] Subtest info: SKIP (0.000s) [95.908957] [007/162] (952s left) fbdev (nullptr) [96.187979] Subtest nullptr: SKIP (0.000s) [96.354502] [008/162] (952s left) fbdev (read) [96.629133] Subtest read: SKIP (0.000s) [96.795731] [009/162] (951s left) fbdev (write) [97.075547] Subtest write: SKIP (0.000s) [97.238129] [010/162] (951s left) gem_basic (bad-close) [97.470843] Starting subtest: bad-close [97.477189] Subtest bad-close: SUCCESS (0.000s) [97.672406] [011/162] (951s left) gem_basic (create-close) [97.891391] Starting subtest: create-close [97.898241] Subtest create-close: SUCCESS (0.001s) [98.070290] [012/162] (951s left) gem_basic (create-fd-close) [98.300235] Starting subtest: create-fd-close [98.303887] Subtest create-fd-close: SUCCESS (0.001s) [98.485296] [013/162] (950s left) gem_busy (busy@all-engines) [98.787144] Starting subtest: busy [98.790219] Starting dynamic subtest: all-engines [98.970490] Dynamic subtest all-engines: SUCCESS (0.187s) [98.972946] Subtest busy: SUCCESS (0.191s) [99.502685] [014/162] (950s left) gem_close_race (basic-process) [99.819196] Starting subtest: basic-process [99.960872] Subtest basic-process: SUCCESS (0.145s) [100.281406] [015/162] (949s left) gem_close_race (basic-threads) [100.568194] Starting subtest: basic-threads [101.799259] Subtest basic-threads: SUCCESS (1.236s) [102.111725] [016/162] (947s left) gem_ctx_create (basic) [102.380539] Starting subtest: basic [102.383454] Subtest basic: SUCCESS (0.000s) [102.679293] [017/162] (947s left) gem_ctx_create (basic-files) [102.955169] Starting subtest: basic-files [105.022858] Subtest basic-files: SUCCESS (2.070s) [105.610598] [018/162] (944s left) gem_ctx_exec (basic) [105.857105] Starting subtest: basic [105.882199] Subtest basic: SUCCESS (0.023s) [106.076505] [019/162] (944s left) gem_exec_basic (basic) [106.335834] Starting subtest: basic [106.340144] Starting dynamic subtest: rcs0-smem [106.346817] Dynamic subtest rcs0-smem: SUCCESS (0.011s) [106.393302] Starting dynamic subtest: bcs0-smem [106.396887] Dynamic subtest bcs0-smem: SUCCESS (0.006s) [106.425698] Starting dynamic subtest: vcs0-smem [106.427827] Dynamic subtest vcs0-smem: SUCCESS (0.005s) [106.458195] Starting dynamic subtest: vecs0-smem [106.460710] Dynamic subtest vecs0-smem: SUCCESS (0.005s) [106.463376] Subtest basic: SUCCESS (0.042s) [106.701415] [020/162] (943s left) gem_exec_create (basic) [106.967294] Starting subtest: basic [106.970200] Starting dynamic subtest: smem [109.067907] Dynamic subtest smem: SUCCESS (2.091s) [109.072328] Subtest basic: SUCCESS (2.092s) [109.370261] [021/162] (941s left) gem_exec_fence (basic-busy) [109.797261] Starting subtest: basic-busy [109.799287] Starting dynamic subtest: rcs0 [109.835368] Dynamic subtest rcs0: SUCCESS (0.036s) [109.890682] Starting dynamic subtest: bcs0 [109.900276] Dynamic subtest bcs0: SUCCESS (0.030s) [109.948047] Starting dynamic subtest: vcs0 [109.951603] Dynamic subtest vcs0: SUCCESS (0.029s) [109.979296] Starting dynamic subtest: vecs0 [109.982249] Dynamic subtest vecs0: SUCCESS (0.042s) [109.983844] Subtest basic-busy: SUCCESS (0.151s) [110.892982] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [110.900326] [022/162] (940s left) gem_exec_fence (basic-wait) [111.343503] Starting subtest: basic-wait [111.345655] Starting dynamic subtest: rcs0 [111.379308] Dynamic subtest rcs0: SUCCESS (0.033s) [111.431114] Starting dynamic subtest: bcs0 [111.435142] Dynamic subtest bcs0: SUCCESS (0.034s) [111.466147] Starting dynamic subtest: vcs0 [111.470702] Dynamic subtest vcs0: SUCCESS (0.035s) [111.516849] Starting dynamic subtest: vecs0 [111.518715] Dynamic subtest vecs0: SUCCESS (0.029s) [111.520499] Subtest basic-wait: SUCCESS (0.146s) [112.264556] [023/162] (938s left) gem_exec_fence (basic-await) [112.699361] Starting subtest: basic-await [112.701811] Starting dynamic subtest: rcs0 [112.897371] Dynamic subtest rcs0: SUCCESS (0.197s) [112.941396] Starting dynamic subtest: bcs0 [113.091612] Dynamic subtest bcs0: SUCCESS (0.195s) [113.136502] Starting dynamic subtest: vcs0 [113.298218] Dynamic subtest vcs0: SUCCESS (0.195s) [113.333095] Starting dynamic subtest: vecs0 [113.493774] Dynamic subtest vecs0: SUCCESS (0.188s) [113.498295] Subtest basic-await: SUCCESS (0.794s) [114.305070] [024/162] (937s left) gem_exec_fence (nb-await) [114.734654] Starting subtest: nb-await [114.737525] Starting dynamic subtest: rcs0 [114.838385] Dynamic subtest rcs0: SUCCESS (0.099s) [114.871502] Starting dynamic subtest: bcs0 [114.925904] Dynamic subtest bcs0: SUCCESS (0.084s) [114.959995] Starting dynamic subtest: vcs0 [115.011485] Dynamic subtest vcs0: SUCCESS (0.082s) [115.043900] Starting dynamic subtest: vecs0 [115.105108] Dynamic subtest vecs0: SUCCESS (0.091s) [115.107737] Subtest nb-await: SUCCESS (0.369s) [115.902563] [025/162] (935s left) gem_exec_gttfill (basic) [116.180274] Starting subtest: basic [150.514352] Subtest basic: SUCCESS (34.331s) [150.881873] [026/162] (900s left) gem_exec_parallel (engines) [151.325304] Starting subtest: engines [151.327309] Starting dynamic subtest: basic [160.026164] Dynamic subtest basic: SUCCESS (8.700s) [160.065166] Starting dynamic subtest: contexts [170.954306] Dynamic subtest contexts: SUCCESS (10.929s) [170.997157] Starting dynamic subtest: fds [183.521663] Dynamic subtest fds: SUCCESS (12.559s) [183.564425] Starting dynamic subtest: userptr [190.017262] Dynamic subtest userptr: SUCCESS (6.494s) [190.020109] Subtest engines: SUCCESS (38.696s) [190.382467] [027/162] (861s left) gem_exec_store (basic) [190.665199] Starting subtest: basic [190.746694] Subtest basic: SUCCESS (0.083s) [191.077997] [028/162] (861s left) gem_flink_basic (bad-flink) [191.311329] Starting subtest: bad-flink [191.315595] Subtest bad-flink: SUCCESS (0.001s) [191.522849] [029/162] (860s left) gem_flink_basic (bad-open) [191.751225] Starting subtest: bad-open [191.756482] Subtest bad-open: SUCCESS (0.000s) [191.962866] [030/162] (860s left) gem_flink_basic (basic) [192.177931] Starting subtest: basic [192.180797] Subtest basic: SUCCESS (0.001s) [192.398587] [031/162] (860s left) gem_flink_basic (double-flink) [192.631132] Starting subtest: double-flink [192.634816] Subtest double-flink: SUCCESS (0.001s) [192.838353] [032/162] (860s left) gem_flink_basic (flink-lifetime) [193.068841] Starting subtest: flink-lifetime [193.079425] Subtest flink-lifetime: SUCCESS (0.012s) [193.315644] [033/162] (860s left) gem_huc_copy (huc-copy) [193.566746] Subtest huc-copy: SKIP (0.000s) [193.787685] [034/162] (859s left) gem_linear_blits (basic) [194.380156] Starting subtest: basic [194.415762] Subtest basic: SUCCESS (0.039s) [194.668530] [035/162] (859s left) gem_mmap (basic) [195.058365] Starting subtest: basic [195.072305] Subtest basic: SUCCESS (0.002s) [195.270402] [036/162] (858s left) gem_mmap_gtt (basic) [195.497216] Starting subtest: basic [195.501586] Subtest basic: SUCCESS (0.005s) [195.716608] [037/162] (858s left) gem_render_linear_blits (basic) [195.952266] Starting subtest: basic [196.089565] Subtest basic: SUCCESS (0.133s) [196.302065] [038/162] (858s left) gem_render_tiled_blits (basic) [196.600868] Starting subtest: basic [196.822266] Subtest basic: SUCCESS (0.217s) [197.043516] [039/162] (857s left) gem_ringfill (basic-all) [197.574856] Starting subtest: basic-all [198.968269] Subtest basic-all: SUCCESS (1.393s) [199.227667] [040/162] (855s left) gem_softpin (allocator-basic) [199.486117] Starting subtest: allocator-basic [199.913295] Subtest allocator-basic: SUCCESS (0.421s) [200.214665] [041/162] (854s left) gem_softpin (allocator-basic-reserve) [200.461368] Starting subtest: allocator-basic-reserve [200.903926] Subtest allocator-basic-reserve: SUCCESS (0.421s) [201.172996] [042/162] (854s left) gem_softpin (safe-alignment) [201.415591] Starting subtest: safe-alignment [201.479806] Subtest safe-alignment: SUCCESS (0.055s) [201.697925] [043/162] (853s left) gem_sync (basic-all) [201.997576] Starting subtest: basic-all [205.514086] Subtest basic-all: SUCCESS (3.518s) [205.872581] [044/162] (849s left) gem_sync (basic-each) [206.166751] Starting subtest: basic-each [209.000463] Subtest basic-each: SUCCESS (2.839s) [209.341468] [045/162] (846s left) gem_tiled_blits (basic) [209.806672] Starting subtest: basic [209.899468] Subtest basic: SUCCESS (0.090s) [210.153089] [046/162] (845s left) gem_tiled_fence_blits (basic) [210.809264] Starting subtest: basic [210.881459] Subtest basic: SUCCESS (0.066s) [211.121371] [047/162] (845s left) gem_tiled_pread_basic (basic) [211.514188] Starting subtest: basic [212.541861] Subtest basic: SUCCESS (1.027s) [212.748857] [048/162] (843s left) gem_wait (busy@all-engines) [213.042089] Starting subtest: busy [213.046315] Starting dynamic subtest: all-engines [213.581866] Dynamic subtest all-engines: SUCCESS (0.539s) [213.584218] Subtest busy: SUCCESS (0.543s) [214.091305] [049/162] (842s left) gem_wait (wait@all-engines) [214.383774] Starting subtest: wait [214.389228] Starting dynamic subtest: all-engines [215.440156] Dynamic subtest all-engines: SUCCESS (1.055s) [215.445150] Subtest wait: SUCCESS (1.059s) [215.845842] [050/162] (841s left) i915_getparams_basic (basic-eu-total) [216.074164] Starting subtest: basic-eu-total [216.079149] Subtest basic-eu-total: SUCCESS (0.001s) [216.280178] [051/162] (840s left) i915_getparams_basic (basic-subslice-total) [216.496585] Starting subtest: basic-subslice-total [216.503098] Subtest basic-subslice-total: SUCCESS (0.000s) [216.696322] [052/162] (840s left) i915_hangman (error-state-basic) [216.964230] Starting subtest: error-state-basic [217.037266] Subtest error-state-basic: SUCCESS (0.061s) [217.377809] [053/162] (840s left) i915_pciid [217.820687] [054/162] (840s left) intel_hwmon (hwmon-read) [218.066440] Subtest hwmon-read: SKIP (0.000s) [218.274299] [055/162] (839s left) intel_hwmon (hwmon-write) [218.499627] Subtest hwmon-write: SKIP (0.000s) [218.699467] [056/162] (839s left) kms_addfb_basic (addfb25-4-tiled) [219.283564] Starting subtest: addfb25-4-tiled [219.289208] Subtest addfb25-4-tiled: SUCCESS (0.001s) [219.487289] [057/162] (839s left) kms_addfb_basic (addfb25-bad-modifier) [220.021348] Starting subtest: addfb25-bad-modifier [220.025713] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [220.243200] [058/162] (838s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [220.897168] Starting subtest: addfb25-framebuffer-vs-set-tiling [220.901177] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [221.114280] [059/162] (837s left) kms_addfb_basic (addfb25-modifier-no-flag) [221.729173] Starting subtest: addfb25-modifier-no-flag [221.734509] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [221.949722] [060/162] (837s left) kms_addfb_basic (addfb25-x-tiled-legacy) [222.508459] Starting subtest: addfb25-x-tiled-legacy [222.512866] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [222.730307] [061/162] (836s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [223.306797] Starting subtest: addfb25-x-tiled-mismatch-legacy [223.308961] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [223.528674] [062/162] (836s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [224.088718] Starting subtest: addfb25-yf-tiled-legacy [224.091222] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s) [224.307517] [063/162] (835s left) kms_addfb_basic (addfb25-y-tiled-legacy) [224.813183] Starting subtest: addfb25-y-tiled-legacy [224.816358] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [225.032277] [064/162] (834s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [225.648255] Starting subtest: addfb25-y-tiled-small-legacy [225.655606] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s) [225.864882] [065/162] (834s left) kms_addfb_basic (bad-pitch-0) [226.090630] Starting subtest: bad-pitch-0 [226.094132] Subtest bad-pitch-0: SUCCESS (0.000s) [226.670788] [066/162] (833s left) kms_addfb_basic (bad-pitch-1024) [226.901233] Starting subtest: bad-pitch-1024 [226.905188] Subtest bad-pitch-1024: SUCCESS (0.000s) [227.474708] [067/162] (833s left) kms_addfb_basic (bad-pitch-128) [227.702222] Starting subtest: bad-pitch-128 [227.707276] Subtest bad-pitch-128: SUCCESS (0.000s) [228.277280] [068/162] (832s left) kms_addfb_basic (bad-pitch-256) [228.517297] Starting subtest: bad-pitch-256 [228.520239] Subtest bad-pitch-256: SUCCESS (0.000s) [229.224574] [069/162] (831s left) kms_addfb_basic (bad-pitch-32) [229.474340] Starting subtest: bad-pitch-32 [229.478362] Subtest bad-pitch-32: SUCCESS (0.000s) [230.014877] [070/162] (831s left) kms_addfb_basic (bad-pitch-63) [230.246640] Starting subtest: bad-pitch-63 [230.249357] Subtest bad-pitch-63: SUCCESS (0.000s) [230.771675] [071/162] (830s left) kms_addfb_basic (bad-pitch-65536) [230.998625] Starting subtest: bad-pitch-65536 [231.003145] Subtest bad-pitch-65536: SUCCESS (0.003s) [231.527476] [072/162] (830s left) kms_addfb_basic (bad-pitch-999) [231.765342] Starting subtest: bad-pitch-999 [231.770383] Subtest bad-pitch-999: SUCCESS (0.000s) [232.300386] [073/162] (829s left) kms_addfb_basic (basic) [232.528167] Starting subtest: basic [232.531175] Subtest basic: SUCCESS (0.000s) [233.049440] [074/162] (829s left) kms_addfb_basic (basic-x-tiled-legacy) [233.295395] Starting subtest: basic-x-tiled-legacy [233.298058] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [233.880212] [075/162] (828s left) kms_addfb_basic (basic-y-tiled-legacy) [234.106695] Starting subtest: basic-y-tiled-legacy [234.110176] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [234.649965] [076/162] (828s left) kms_addfb_basic (bo-too-small) [235.257308] Starting subtest: bo-too-small [235.261048] Subtest bo-too-small: SUCCESS (0.002s) [235.477238] [077/162] (827s left) kms_addfb_basic (bo-too-small-due-to-tiling) [236.004556] Starting subtest: bo-too-small-due-to-tiling [236.007886] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [236.223578] [078/162] (826s left) kms_addfb_basic (clobberred-modifier) [236.449552] Starting subtest: clobberred-modifier [236.451648] Subtest clobberred-modifier: SUCCESS (0.000s) [236.982776] [079/162] (826s left) kms_addfb_basic (framebuffer-vs-set-tiling) [237.224309] Starting subtest: framebuffer-vs-set-tiling [237.226711] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [237.781070] [080/162] (825s left) kms_addfb_basic (invalid-get-prop) [238.014252] Starting subtest: invalid-get-prop [238.016303] Subtest invalid-get-prop: SUCCESS (0.000s) [238.552833] [081/162] (825s left) kms_addfb_basic (invalid-get-prop-any) [238.789544] Starting subtest: invalid-get-prop-any [238.793125] Subtest invalid-get-prop-any: SUCCESS (0.000s) [239.338487] [082/162] (824s left) kms_addfb_basic (invalid-set-prop) [239.569326] Starting subtest: invalid-set-prop [239.572172] Subtest invalid-set-prop: SUCCESS (0.000s) [240.165709] [083/162] (823s left) kms_addfb_basic (invalid-set-prop-any) [240.403254] Starting subtest: invalid-set-prop-any [240.407234] Subtest invalid-set-prop-any: SUCCESS (0.000s) [240.976561] [084/162] (823s left) kms_addfb_basic (no-handle) [241.207505] Starting subtest: no-handle [241.210567] Subtest no-handle: SUCCESS (0.000s) [241.808526] [085/162] (822s left) kms_addfb_basic (size-max) [242.412185] Starting subtest: size-max [242.417092] Subtest size-max: SUCCESS (0.002s) [242.625581] [086/162] (822s left) kms_addfb_basic (small-bo) [243.255413] Starting subtest: small-bo [243.257625] Subtest small-bo: SUCCESS (0.000s) [243.478643] [087/162] (821s left) kms_addfb_basic (tile-pitch-mismatch) [243.708679] Starting subtest: tile-pitch-mismatch [243.712160] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [244.385721] [088/162] (820s left) kms_addfb_basic (too-high) [244.937827] Starting subtest: too-high [244.941272] Subtest too-high: SUCCESS (0.005s) [245.158874] [089/162] (820s left) kms_addfb_basic (too-wide) [245.710500] Starting subtest: too-wide [245.715162] Subtest too-wide: SUCCESS (0.000s) [245.927464] [090/162] (819s left) kms_addfb_basic (unused-handle) [246.168788] Starting subtest: unused-handle [246.173245] Subtest unused-handle: SUCCESS (0.001s) [246.769224] [091/162] (819s left) kms_addfb_basic (unused-modifier) [246.994972] Starting subtest: unused-modifier [246.999335] Subtest unused-modifier: SUCCESS (0.000s) [247.581992] [092/162] (818s left) kms_addfb_basic (unused-offsets) [247.880763] Starting subtest: unused-offsets [247.884452] Subtest unused-offsets: SUCCESS (0.000s) [248.383396] [093/162] (817s left) kms_addfb_basic (unused-pitches) [248.630515] Starting subtest: unused-pitches [248.634368] Subtest unused-pitches: SUCCESS (0.000s) [249.188554] [094/162] (817s left) kms_busy (basic) [249.793804] Subtest basic: SKIP (0.000s) [250.002718] [095/162] (816s left) kms_prop_blob (basic) [250.233405] Starting subtest: basic [250.238384] Subtest basic: SUCCESS (0.000s) [250.444383] [096/162] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [251.079317] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [251.267885] [097/162] (815s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [251.866802] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [252.071692] [098/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [252.654188] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [252.856732] [099/162] (814s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [253.456048] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [253.650570] [100/162] (814s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [254.170837] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [254.374118] [101/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [254.925432] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [255.111744] [102/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [255.675159] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [255.878474] [103/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [256.477211] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [256.674784] [104/162] (811s left) kms_dsc (dsc-basic) [257.204304] Subtest dsc-basic: SKIP (0.000s) [257.416547] [105/162] (811s left) kms_flip (basic-flip-vs-dpms) [257.920165] Starting subtest: basic-flip-vs-dpms [257.937680] Subtest basic-flip-vs-dpms: SKIP (0.006s) [258.208821] [106/162] (810s left) kms_flip (basic-flip-vs-modeset) [258.818508] Starting subtest: basic-flip-vs-modeset [258.830510] Subtest basic-flip-vs-modeset: SKIP (0.009s) [259.116317] [107/162] (810s left) kms_flip (basic-flip-vs-wf_vblank) [259.700108] Starting subtest: basic-flip-vs-wf_vblank [259.711497] Subtest basic-flip-vs-wf_vblank: SKIP (0.012s) [259.989551] [108/162] (809s left) kms_flip (basic-plain-flip) [260.505520] Starting subtest: basic-plain-flip [260.513140] Subtest basic-plain-flip: SKIP (0.007s) [260.783248] [109/162] (808s left) kms_force_connector_basic (force-connector-state) [261.174178] Starting subtest: force-connector-state [261.917579] Subtest force-connector-state: SUCCESS (0.709s) [263.052604] [110/162] (806s left) kms_force_connector_basic (force-edid) [263.396093] Starting subtest: force-edid [263.564431] Subtest force-edid: SUCCESS (0.166s) [264.225209] [111/162] (805s left) kms_force_connector_basic (force-load-detect) [264.617416] Starting subtest: force-load-detect [264.630883] Subtest force-load-detect: SKIP (0.002s) [265.179558] [112/162] (805s left) kms_force_connector_basic (prune-stale-modes) [265.575199] Starting subtest: prune-stale-modes [265.812462] Subtest prune-stale-modes: SUCCESS (0.240s) [266.429708] [113/162] (804s left) kms_frontbuffer_tracking (basic) [267.009308] Subtest basic: SKIP (0.000s) [267.226818] [114/162] (803s left) kms_hdmi_inject (inject-audio) [267.461743] Starting subtest: inject-audio [267.951899] Subtest inject-audio: SUCCESS (0.487s) [268.415108] [115/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [268.986544] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [269.205788] [116/162] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [269.809682] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [270.043906] [117/162] (801s left) kms_pipe_crc_basic (hang-read-crc) [270.655157] Subtest hang-read-crc: SKIP (0.000s) [270.883775] [118/162] (800s left) kms_pipe_crc_basic (nonblocking-crc) [271.509154] Subtest nonblocking-crc: SKIP (0.000s) [271.745893] [119/162] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [272.325553] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [272.546402] [120/162] (799s left) kms_pipe_crc_basic (read-crc) [273.102350] Subtest read-crc: SKIP (0.000s) [273.332437] [121/162] (798s left) kms_pipe_crc_basic (read-crc-frame-sequence) [273.928309] Subtest read-crc-frame-sequence: SKIP (0.000s) [274.211875] [122/162] (798s left) kms_pm_backlight (basic-brightness) [274.762348] Subtest basic-brightness: SKIP (0.000s) [274.975803] [123/162] (797s left) kms_pm_rpm (basic-pci-d3-state) [276.779439] Starting subtest: basic-pci-d3-state [276.993300] Subtest basic-pci-d3-state: SUCCESS (0.213s) [277.224485] [124/162] (795s left) kms_pm_rpm (basic-rte) [277.436897] Starting subtest: basic-rte [279.237278] Subtest basic-rte: SUCCESS (1.796s) [279.692338] [125/162] (793s left) kms_psr (psr-primary-page-flip) [280.317380] Subtest psr-primary-page-flip: SKIP (0.000s) [280.547646] [126/162] (792s left) kms_psr (psr-cursor-plane-move) [281.141476] Subtest psr-cursor-plane-move: SKIP (0.000s) [281.360681] [127/162] (792s left) kms_psr (psr-sprite-plane-onoff) [281.956462] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [282.180498] [128/162] (791s left) kms_psr (psr-primary-mmap-gtt) [282.756874] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [282.992325] [129/162] (790s left) kms_setmode (basic-clone-single-crtc) [283.221825] Starting subtest: basic-clone-single-crtc [283.234428] Subtest basic-clone-single-crtc: SKIP (0.000s) [283.456336] [130/162] (790s left) i915_pm_rps (basic-api) [283.741284] Starting subtest: basic-api [283.759171] Subtest basic-api: SUCCESS (0.019s) [284.003426] [131/162] (790s left) prime_self_import (basic-llseek-bad) [284.243650] Starting subtest: basic-llseek-bad [284.250863] Subtest basic-llseek-bad: SUCCESS (0.011s) [284.476393] [132/162] (790s left) prime_self_import (basic-llseek-size) [284.698584] Starting subtest: basic-llseek-size [284.726467] Subtest basic-llseek-size: SUCCESS (0.027s) [284.958466] [133/162] (789s left) prime_self_import (basic-with_fd_dup) [285.183860] Starting subtest: basic-with_fd_dup [285.197373] Subtest basic-with_fd_dup: SUCCESS (0.019s) [285.440449] [134/162] (789s left) prime_self_import (basic-with_one_bo) [285.661443] Starting subtest: basic-with_one_bo [285.682466] Subtest basic-with_one_bo: SUCCESS (0.023s) [285.921655] [135/162] (789s left) prime_self_import (basic-with_one_bo_two_files) [286.141560] Starting subtest: basic-with_one_bo_two_files [286.158950] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s) [286.404607] [136/162] (789s left) prime_self_import (basic-with_two_bos) [286.620601] Starting subtest: basic-with_two_bos [286.644048] Subtest basic-with_two_bos: SUCCESS (0.028s) [286.875280] [137/162] (788s left) prime_vgem (basic-fence-flip) [287.149222] Starting subtest: basic-fence-flip [287.508674] Subtest basic-fence-flip: SKIP (0.352s) [287.746766] [138/162] (788s left) prime_vgem (basic-fence-mmap) [288.037904] Starting subtest: basic-fence-mmap [288.166620] Subtest basic-fence-mmap: SUCCESS (0.137s) [288.409996] [139/162] (787s left) prime_vgem (basic-fence-read) [288.724219] Starting subtest: basic-fence-read [289.009162] Subtest basic-fence-read: SUCCESS (0.287s) [289.278631] [140/162] (787s left) prime_vgem (basic-gtt) [289.530200] Starting subtest: basic-gtt [289.601375] Subtest basic-gtt: SUCCESS (0.071s) [289.854314] [141/162] (786s left) prime_vgem (basic-read) [290.124305] Starting subtest: basic-read [290.251062] Subtest basic-read: SUCCESS (0.133s) [290.514409] [142/162] (786s left) prime_vgem (basic-write) [290.786156] Starting subtest: basic-write [290.961252] Subtest basic-write: SUCCESS (0.177s) [291.200630] [143/162] (785s left) vgem_basic (setversion) [291.434253] Starting subtest: setversion [291.441160] Subtest setversion: SUCCESS (0.000s) [291.649484] [144/162] (785s left) vgem_basic (create) [291.890320] Starting subtest: create [291.893865] Subtest create: SUCCESS (0.002s) [292.126625] [145/162] (785s left) vgem_basic (debugfs) [292.347437] Starting subtest: debugfs [292.352150] Subtest debugfs: SUCCESS (0.002s) [292.571533] [146/162] (785s left) vgem_basic (dmabuf-export) [292.803727] Starting subtest: dmabuf-export [292.811164] Subtest dmabuf-export: SUCCESS (0.013s) [293.045486] [147/162] (784s left) vgem_basic (dmabuf-fence) [293.273572] Starting subtest: dmabuf-fence [293.277185] Subtest dmabuf-fence: SUCCESS (0.004s) [293.495891] [148/162] (784s left) vgem_basic (dmabuf-fence-before) [293.730467] Starting subtest: dmabuf-fence-before [293.734792] Subtest dmabuf-fence-before: SUCCESS (0.003s) [293.962438] [149/162] (784s left) vgem_basic (dmabuf-mmap) [294.196372] Starting subtest: dmabuf-mmap [294.239722] Subtest dmabuf-mmap: SUCCESS (0.045s) [294.460362] [150/162] (784s left) vgem_basic (mmap) [294.697962] Starting subtest: mmap [294.724988] Subtest mmap: SUCCESS (0.031s) [294.960700] [151/162] (783s left) vgem_basic (second-client) [295.193863] Starting subtest: second-client [295.208570] Subtest second-client: SUCCESS (0.019s) [295.428572] [152/162] (783s left) vgem_basic (sysfs) [295.663515] Starting subtest: sysfs [295.667210] Subtest sysfs: SUCCESS (0.002s) [295.895637] [153/162] (783s left) core_hotunplug (unbind-rebind) [296.306321] Starting subtest: unbind-rebind [301.748237] Subtest unbind-rebind: SUCCESS (5.441s) [301.965278] [154/162] (777s left) vgem_basic (unload) [302.192192] Starting subtest: unload [331.390280] Subtest unload: SUCCESS (29.195s) [331.729768] [155/162] (747s left) i915_module_load (reload) [331.954803] Starting subtest: reload [339.616442] Subtest reload: SUCCESS (7.654s) [339.987178] [156/162] (739s left) gem_lmem_swapping (basic) [340.287511] Subtest basic: SKIP (0.000s) [340.489842] [157/162] (739s left) gem_lmem_swapping (parallel-random-engines) [340.740494] Subtest parallel-random-engines: SKIP (0.000s) [340.964366] [158/162] (739s left) gem_lmem_swapping (random-engines) [341.214120] Subtest random-engines: SKIP (0.000s) [341.442632] [159/162] (739s left) gem_lmem_swapping (verify-random) [341.705150] Subtest verify-random: SKIP (0.000s) [341.916763] [160/162] (738s left) i915_pm_rpm (module-reload) [343.865160] Starting subtest: module-reload [362.965306] Subtest module-reload: SUCCESS (19.095s) [363.116855] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [363.122603] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [363.135678] [161/162] (717s left) i915_selftest (live) [363.390555] Starting subtest: live [363.393417] Starting dynamic subtest: sanitycheck [369.560171] Dynamic subtest sanitycheck: SUCCESS (6.167s) [369.598888] Starting dynamic subtest: uncore [375.602211] Dynamic subtest uncore: SUCCESS (6.041s) [375.644347] Starting dynamic subtest: workarounds [382.334442] Dynamic subtest workarounds: SUCCESS (6.725s) [382.374955] Starting dynamic subtest: gt_engines [389.000723] Dynamic subtest gt_engines: SUCCESS (6.658s) [389.035684] Starting dynamic subtest: gt_timelines [427.388947] Dynamic subtest gt_timelines: SUCCESS (38.386s) [427.426322] Starting dynamic subtest: gt_contexts [433.739615] Dynamic subtest gt_contexts: SUCCESS (6.343s) [433.774947] Starting dynamic subtest: gt_lrc [443.478372] Dynamic subtest gt_lrc: SUCCESS (9.736s) [443.524383] Starting dynamic subtest: gt_mocs [449.342425] Dynamic subtest gt_mocs: SUCCESS (5.854s) [449.381737] Starting dynamic subtest: gt_pm [457.050237] Dynamic subtest gt_pm: SUCCESS (7.697s) [457.085893] Starting dynamic subtest: gt_heartbeat [463.060900] Dynamic subtest gt_heartbeat: SUCCESS (6.009s) [463.098972] Starting dynamic subtest: gt_tlb [469.744954] Dynamic subtest gt_tlb: SUCCESS (6.673s) [469.885774] Starting dynamic subtest: requests [482.518400] Dynamic subtest requests: SUCCESS (12.766s) [482.552075] Starting dynamic subtest: migrate [493.136616] Dynamic subtest migrate: SUCCESS (10.616s) [493.176178] Starting dynamic subtest: active [499.477231] Dynamic subtest active: SUCCESS (6.333s) [499.580255] Starting dynamic subtest: objects [507.794961] Dynamic subtest objects: SUCCESS (8.295s) [507.833517] Starting dynamic subtest: mman [521.318431] Dynamic subtest mman: SUCCESS (13.516s) [521.356573] Starting dynamic subtest: dmabuf [527.407265] Dynamic subtest dmabuf: SUCCESS (6.077s) [527.461344] Starting dynamic subtest: vma [533.444214] Dynamic subtest vma: SUCCESS (6.016s) [533.565276] Starting dynamic subtest: coherency [545.331438] Dynamic subtest coherency: SUCCESS (11.889s) [545.372487] Starting dynamic subtest: gtt [559.682858] Dynamic subtest gtt: SUCCESS (14.342s) [559.746776] Starting dynamic subtest: gem [567.050517] Dynamic subtest gem: SUCCESS (7.356s) [567.091095] Starting dynamic subtest: evict [581.780143] Dynamic subtest evict: SUCCESS (14.719s) [581.815353] Starting dynamic subtest: hugepages [588.348632] Dynamic subtest hugepages: SUCCESS (6.566s) [588.390132] Starting dynamic subtest: gem_contexts [623.181853] Dynamic subtest gem_contexts: SUCCESS (34.825s) [623.224217] Starting dynamic subtest: client [629.450267] Dynamic subtest client: SUCCESS (6.257s) [629.491345] Starting dynamic subtest: gem_migrate [635.498834] Dynamic subtest gem_migrate: SUCCESS (6.042s) [635.620281] Starting dynamic subtest: reset [650.086262] Dynamic subtest reset: SUCCESS (14.568s) [650.125693] Starting dynamic subtest: memory_region [656.375532] Dynamic subtest memory_region: SUCCESS (6.282s) [656.418071] Starting dynamic subtest: hangcheck [686.161728] Dynamic subtest hangcheck: SUCCESS (29.775s) [686.201995] Starting dynamic subtest: execlists [698.752887] Dynamic subtest execlists: SUCCESS (12.584s) [698.804623] Starting dynamic subtest: ring_submission [704.506317] Dynamic subtest ring_submission: SUCCESS (5.745s) [704.607106] Starting dynamic subtest: perf [711.324937] Dynamic subtest perf: SUCCESS (6.801s) [711.370530] Starting dynamic subtest: slpc [717.317609] Dynamic subtest slpc: SUCCESS (5.980s) [717.354067] Starting dynamic subtest: guc [723.260182] Dynamic subtest guc: SUCCESS (5.939s) [723.366502] Starting dynamic subtest: guc_multi_lrc [729.388160] Dynamic subtest guc_multi_lrc: SUCCESS (6.111s) [729.436471] Starting dynamic subtest: guc_hang [735.414449] Dynamic subtest guc_hang: SUCCESS (6.012s) [735.461206] Starting dynamic subtest: late_gt_pm [741.712470] Dynamic subtest late_gt_pm: SUCCESS (6.293s) [741.716699] Subtest live: SUCCESS (378.320s) [741.883778] [162/162] (339s left) dmabuf (all-tests) [742.121389] Starting subtest: all-tests [742.125995] Subtest all-tests: SKIP (0.000s) [742.263448] 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.