[80.748442] Initializing watchdogs [80.748820] /dev/watchdog0 [80.840995] [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 [80.861374] [001/162] (960s left) i915_module_load (load) [81.964224] Starting subtest: load [87.885371] Subtest load: SUCCESS (5.843s) [88.116397] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [88.126160] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [88.136304] [002/162] (953s left) core_auth (basic-auth) [88.384785] Starting subtest: basic-auth [88.392397] Subtest basic-auth: SUCCESS (0.007s) [88.575192] [003/162] (953s left) core_debugfs (read-all-entries) [88.801726] Starting subtest: read-all-entries [88.812179] Subtest read-all-entries: SUCCESS (0.011s) [88.998922] [004/162] (952s left) core_sysfs (read-all-entries) [89.232796] Starting subtest: read-all-entries [89.248537] Subtest read-all-entries: SUCCESS (0.018s) [89.424881] [005/162] (952s left) fbdev (eof) [89.702940] Subtest eof: SKIP (0.000s) [89.871570] [006/162] (952s left) fbdev (info) [90.143574] Subtest info: SKIP (0.000s) [90.309345] [007/162] (952s left) fbdev (nullptr) [90.594166] Subtest nullptr: SKIP (0.000s) [90.757559] [008/162] (951s left) fbdev (read) [91.027204] Subtest read: SKIP (0.000s) [91.193629] [009/162] (951s left) fbdev (write) [91.464219] Subtest write: SKIP (0.000s) [91.645889] [010/162] (951s left) gem_basic (bad-close) [91.885218] Starting subtest: bad-close [91.892666] Subtest bad-close: SUCCESS (0.000s) [92.056297] [011/162] (951s left) gem_basic (create-close) [92.293549] Starting subtest: create-close [92.299167] Subtest create-close: SUCCESS (0.001s) [92.480354] [012/162] (950s left) gem_basic (create-fd-close) [92.701385] Starting subtest: create-fd-close [92.710207] Subtest create-fd-close: SUCCESS (0.002s) [92.899063] [013/162] (950s left) gem_busy (busy@all-engines) [93.191239] Starting subtest: busy [93.197172] Starting dynamic subtest: all-engines [93.372310] Dynamic subtest all-engines: SUCCESS (0.177s) [93.376202] Subtest busy: SUCCESS (0.179s) [93.895304] [014/162] (949s left) gem_close_race (basic-process) [94.180284] Starting subtest: basic-process [94.316989] Subtest basic-process: SUCCESS (0.140s) [94.749710] [015/162] (949s left) gem_close_race (basic-threads) [95.071374] Starting subtest: basic-threads [96.386184] Subtest basic-threads: SUCCESS (1.313s) [96.718160] [016/162] (947s left) gem_ctx_create (basic) [97.008427] Starting subtest: basic [97.010392] Subtest basic: SUCCESS (0.001s) [97.312416] [017/162] (947s left) gem_ctx_create (basic-files) [97.610440] Starting subtest: basic-files [99.676097] Subtest basic-files: SUCCESS (2.065s) [99.990904] [018/162] (944s left) gem_ctx_exec (basic) [100.237664] Starting subtest: basic [100.254218] Subtest basic: SUCCESS (0.018s) [100.450956] [019/162] (944s left) gem_exec_basic (basic) [100.717493] Starting subtest: basic [100.723250] Starting dynamic subtest: rcs0-smem [100.725947] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [100.762165] Starting dynamic subtest: bcs0-smem [100.763846] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [100.790725] Starting dynamic subtest: vcs0-smem [100.792435] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [100.818814] Starting dynamic subtest: vecs0-smem [100.820492] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [100.822184] Subtest basic: SUCCESS (0.027s) [101.054810] [020/162] (943s left) gem_exec_create (basic) [101.331240] Starting subtest: basic [101.335497] Starting dynamic subtest: smem [103.421778] Dynamic subtest smem: SUCCESS (2.082s) [103.423592] Subtest basic: SUCCESS (2.083s) [103.731323] [021/162] (941s left) gem_exec_fence (basic-busy) [104.165674] Starting subtest: basic-busy [104.171244] Starting dynamic subtest: rcs0 [104.213928] Dynamic subtest rcs0: SUCCESS (0.047s) [104.252375] Starting dynamic subtest: bcs0 [104.259207] Dynamic subtest bcs0: SUCCESS (0.038s) [104.287736] Starting dynamic subtest: vcs0 [104.291794] Dynamic subtest vcs0: SUCCESS (0.031s) [104.320746] Starting dynamic subtest: vecs0 [104.332299] Dynamic subtest vecs0: SUCCESS (0.035s) [104.334149] Subtest basic-busy: SUCCESS (0.167s) [105.307904] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [105.314947] [022/162] (939s left) gem_exec_fence (basic-wait) [105.746524] Starting subtest: basic-wait [105.748272] Starting dynamic subtest: rcs0 [105.794828] Dynamic subtest rcs0: SUCCESS (0.044s) [105.832104] Starting dynamic subtest: bcs0 [105.834241] Dynamic subtest bcs0: SUCCESS (0.029s) [105.864302] Starting dynamic subtest: vcs0 [105.866660] Dynamic subtest vcs0: SUCCESS (0.025s) [105.896517] Starting dynamic subtest: vecs0 [105.898234] Dynamic subtest vecs0: SUCCESS (0.025s) [105.899922] Subtest basic-wait: SUCCESS (0.143s) [106.670730] [023/162] (938s left) gem_exec_fence (basic-await) [107.112225] Starting subtest: basic-await [107.117265] Starting dynamic subtest: rcs0 [107.313173] Dynamic subtest rcs0: SUCCESS (0.198s) [107.350763] Starting dynamic subtest: bcs0 [107.508470] Dynamic subtest bcs0: SUCCESS (0.185s) [107.540214] Starting dynamic subtest: vcs0 [107.703750] Dynamic subtest vcs0: SUCCESS (0.193s) [107.732899] Starting dynamic subtest: vecs0 [107.896446] Dynamic subtest vecs0: SUCCESS (0.192s) [107.899917] Subtest basic-await: SUCCESS (0.783s) [108.673117] [024/162] (937s left) gem_exec_fence (nb-await) [109.110179] Starting subtest: nb-await [109.113162] Starting dynamic subtest: rcs0 [109.213841] Dynamic subtest rcs0: SUCCESS (0.099s) [109.247677] Starting dynamic subtest: bcs0 [109.313470] Dynamic subtest bcs0: SUCCESS (0.098s) [109.349097] Starting dynamic subtest: vcs0 [109.416573] Dynamic subtest vcs0: SUCCESS (0.095s) [109.456897] Starting dynamic subtest: vecs0 [109.508072] Dynamic subtest vecs0: SUCCESS (0.092s) [109.516421] Subtest nb-await: SUCCESS (0.397s) [110.301230] [025/162] (935s left) gem_exec_gttfill (basic) [110.578764] Starting subtest: basic [144.116923] Subtest basic: SUCCESS (33.535s) [144.495672] [026/162] (901s left) gem_exec_parallel (engines) [144.971223] Starting subtest: engines [144.974104] Starting dynamic subtest: basic [154.671094] Dynamic subtest basic: SUCCESS (9.696s) [154.711397] Starting dynamic subtest: contexts [165.542227] Dynamic subtest contexts: SUCCESS (10.862s) [165.582219] Starting dynamic subtest: fds [178.284335] Dynamic subtest fds: SUCCESS (12.739s) [178.329843] Starting dynamic subtest: userptr [185.051891] Dynamic subtest userptr: SUCCESS (6.764s) [185.053961] Subtest engines: SUCCESS (40.081s) [185.445815] [027/162] (860s left) gem_exec_store (basic) [185.721352] Starting subtest: basic [185.800252] Subtest basic: SUCCESS (0.077s) [186.136587] [028/162] (860s left) gem_flink_basic (bad-flink) [186.354915] Starting subtest: bad-flink [186.358441] Subtest bad-flink: SUCCESS (0.000s) [186.550804] [029/162] (860s left) gem_flink_basic (bad-open) [186.769370] Starting subtest: bad-open [186.773699] Subtest bad-open: SUCCESS (0.000s) [186.977560] [030/162] (859s left) gem_flink_basic (basic) [187.204601] Starting subtest: basic [187.208482] Subtest basic: SUCCESS (0.000s) [187.419908] [031/162] (859s left) gem_flink_basic (double-flink) [187.731370] Starting subtest: double-flink [187.737890] Subtest double-flink: SUCCESS (0.001s) [187.950479] [032/162] (859s left) gem_flink_basic (flink-lifetime) [188.177163] Starting subtest: flink-lifetime [188.187470] Subtest flink-lifetime: SUCCESS (0.009s) [188.398466] [033/162] (859s left) gem_huc_copy (huc-copy) [188.654439] Subtest huc-copy: SKIP (0.000s) [188.871293] [034/162] (858s left) gem_linear_blits (basic) [189.448879] Starting subtest: basic [189.487186] Subtest basic: SUCCESS (0.037s) [189.712447] [035/162] (858s left) gem_mmap (basic) [190.097782] Starting subtest: basic [190.113074] Subtest basic: SUCCESS (0.001s) [190.311147] [036/162] (857s left) gem_mmap_gtt (basic) [190.542682] Starting subtest: basic [190.546208] Subtest basic: SUCCESS (0.004s) [190.756259] [037/162] (857s left) gem_render_linear_blits (basic) [191.001974] Starting subtest: basic [191.148335] Subtest basic: SUCCESS (0.141s) [191.378814] [038/162] (857s left) gem_render_tiled_blits (basic) [191.659325] Starting subtest: basic [191.860250] Subtest basic: SUCCESS (0.194s) [192.076814] [039/162] (856s left) gem_ringfill (basic-all) [192.583142] Starting subtest: basic-all [193.860543] Subtest basic-all: SUCCESS (1.286s) [194.090483] [040/162] (855s left) gem_softpin (allocator-basic) [194.344712] Starting subtest: allocator-basic [194.789282] Subtest allocator-basic: SUCCESS (0.431s) [195.041953] [041/162] (854s left) gem_softpin (allocator-basic-reserve) [195.302271] Starting subtest: allocator-basic-reserve [195.732196] Subtest allocator-basic-reserve: SUCCESS (0.431s) [195.995900] [042/162] (853s left) gem_softpin (safe-alignment) [196.252236] Starting subtest: safe-alignment [196.309143] Subtest safe-alignment: SUCCESS (0.053s) [196.516910] [043/162] (853s left) gem_sync (basic-all) [196.800255] Starting subtest: basic-all [200.290258] Subtest basic-all: SUCCESS (3.487s) [200.631282] [044/162] (849s left) gem_sync (basic-each) [200.899303] Starting subtest: basic-each [204.001399] Subtest basic-each: SUCCESS (3.104s) [204.348039] [045/162] (845s left) gem_tiled_blits (basic) [204.801141] Starting subtest: basic [204.886139] Subtest basic: SUCCESS (0.085s) [205.120187] [046/162] (845s left) gem_tiled_fence_blits (basic) [205.756423] Starting subtest: basic [205.833946] Subtest basic: SUCCESS (0.068s) [206.067679] [047/162] (844s left) gem_tiled_pread_basic (basic) [206.466238] Starting subtest: basic [207.523478] Subtest basic: SUCCESS (1.054s) [207.734849] [048/162] (843s left) gem_wait (busy@all-engines) [208.059239] Starting subtest: busy [208.064366] Starting dynamic subtest: all-engines [208.607413] Dynamic subtest all-engines: SUCCESS (0.550s) [208.611086] Subtest busy: SUCCESS (0.556s) [209.020220] [049/162] (841s left) gem_wait (wait@all-engines) [209.363776] Starting subtest: wait [209.367821] Starting dynamic subtest: all-engines [210.436904] Dynamic subtest all-engines: SUCCESS (1.076s) [210.443648] Subtest wait: SUCCESS (1.077s) [211.178261] [050/162] (840s left) i915_getparams_basic (basic-eu-total) [211.453234] Starting subtest: basic-eu-total [211.460312] Subtest basic-eu-total: SUCCESS (0.000s) [211.657458] [051/162] (840s left) i915_getparams_basic (basic-subslice-total) [211.920825] Starting subtest: basic-subslice-total [211.940390] Subtest basic-subslice-total: SUCCESS (0.000s) [212.128477] [052/162] (839s left) i915_hangman (error-state-basic) [212.404909] Starting subtest: error-state-basic [212.442121] Subtest error-state-basic: SUCCESS (0.023s) [212.729351] [053/162] (839s left) i915_pciid [213.151346] [054/162] (839s left) intel_hwmon (hwmon-read) [213.381690] Subtest hwmon-read: SKIP (0.000s) [213.584983] [055/162] (838s left) intel_hwmon (hwmon-write) [213.813939] Subtest hwmon-write: SKIP (0.000s) [214.009892] [056/162] (838s left) kms_addfb_basic (addfb25-4-tiled) [214.561595] Starting subtest: addfb25-4-tiled [214.564828] Subtest addfb25-4-tiled: SUCCESS (0.001s) [214.768963] [057/162] (838s left) kms_addfb_basic (addfb25-bad-modifier) [215.308593] Starting subtest: addfb25-bad-modifier [215.312803] Subtest addfb25-bad-modifier: SUCCESS (0.003s) [215.530255] [058/162] (837s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [216.077713] Starting subtest: addfb25-framebuffer-vs-set-tiling [216.082482] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [216.301110] [059/162] (837s left) kms_addfb_basic (addfb25-modifier-no-flag) [216.905844] Starting subtest: addfb25-modifier-no-flag [216.908905] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [217.127916] [060/162] (836s left) kms_addfb_basic (addfb25-x-tiled-legacy) [217.904539] Starting subtest: addfb25-x-tiled-legacy [217.908424] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [218.126922] [061/162] (835s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [218.630474] Starting subtest: addfb25-x-tiled-mismatch-legacy [218.633755] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [218.839417] [062/162] (835s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [219.427717] Starting subtest: addfb25-yf-tiled-legacy [219.431233] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [219.650416] [063/162] (834s left) kms_addfb_basic (addfb25-y-tiled-legacy) [220.251182] Starting subtest: addfb25-y-tiled-legacy [220.257147] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [220.470480] [064/162] (833s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [221.025984] Starting subtest: addfb25-y-tiled-small-legacy [221.034499] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [221.244860] [065/162] (833s left) kms_addfb_basic (bad-pitch-0) [221.475374] Starting subtest: bad-pitch-0 [221.479269] Subtest bad-pitch-0: SUCCESS (0.000s) [222.005699] [066/162] (832s left) kms_addfb_basic (bad-pitch-1024) [222.283818] Starting subtest: bad-pitch-1024 [222.288308] Subtest bad-pitch-1024: SUCCESS (0.000s) [222.857533] [067/162] (832s left) kms_addfb_basic (bad-pitch-128) [223.085893] Starting subtest: bad-pitch-128 [223.090232] Subtest bad-pitch-128: SUCCESS (0.000s) [223.638811] [068/162] (831s left) kms_addfb_basic (bad-pitch-256) [223.863642] Starting subtest: bad-pitch-256 [223.867099] Subtest bad-pitch-256: SUCCESS (0.000s) [224.448819] [069/162] (831s left) kms_addfb_basic (bad-pitch-32) [224.694196] Starting subtest: bad-pitch-32 [224.697504] Subtest bad-pitch-32: SUCCESS (0.000s) [225.248405] [070/162] (830s left) kms_addfb_basic (bad-pitch-63) [225.475419] Starting subtest: bad-pitch-63 [225.480201] Subtest bad-pitch-63: SUCCESS (0.001s) [225.987973] [071/162] (829s left) kms_addfb_basic (bad-pitch-65536) [226.210643] Starting subtest: bad-pitch-65536 [226.214311] Subtest bad-pitch-65536: SUCCESS (0.002s) [226.794946] [072/162] (829s left) kms_addfb_basic (bad-pitch-999) [227.020992] Starting subtest: bad-pitch-999 [227.023588] Subtest bad-pitch-999: SUCCESS (0.000s) [227.586931] [073/162] (828s left) kms_addfb_basic (basic) [227.812372] Starting subtest: basic [227.816225] Subtest basic: SUCCESS (0.000s) [228.307911] [074/162] (828s left) kms_addfb_basic (basic-x-tiled-legacy) [228.547176] Starting subtest: basic-x-tiled-legacy [228.551218] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [229.058236] [075/162] (827s left) kms_addfb_basic (basic-y-tiled-legacy) [229.301852] Starting subtest: basic-y-tiled-legacy [229.306415] Subtest basic-y-tiled-legacy: SUCCESS (0.003s) [229.853871] [076/162] (827s left) kms_addfb_basic (bo-too-small) [230.383474] Starting subtest: bo-too-small [230.387703] Subtest bo-too-small: SUCCESS (0.001s) [230.593628] [077/162] (826s left) kms_addfb_basic (bo-too-small-due-to-tiling) [231.135304] Starting subtest: bo-too-small-due-to-tiling [231.139209] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [231.357916] [078/162] (825s left) kms_addfb_basic (clobberred-modifier) [231.590086] Starting subtest: clobberred-modifier [231.595203] Subtest clobberred-modifier: SUCCESS (0.000s) [232.168833] [079/162] (825s left) kms_addfb_basic (framebuffer-vs-set-tiling) [232.456330] Starting subtest: framebuffer-vs-set-tiling [232.460302] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [232.994692] [080/162] (824s left) kms_addfb_basic (invalid-get-prop) [233.224200] Starting subtest: invalid-get-prop [233.227260] Subtest invalid-get-prop: SUCCESS (0.000s) [233.826458] [081/162] (824s left) kms_addfb_basic (invalid-get-prop-any) [234.062228] Starting subtest: invalid-get-prop-any [234.065623] Subtest invalid-get-prop-any: SUCCESS (0.000s) [234.638691] [082/162] (823s left) kms_addfb_basic (invalid-set-prop) [234.878198] Starting subtest: invalid-set-prop [234.880215] Subtest invalid-set-prop: SUCCESS (0.000s) [235.426676] [083/162] (822s left) kms_addfb_basic (invalid-set-prop-any) [235.662270] Starting subtest: invalid-set-prop-any [235.664492] Subtest invalid-set-prop-any: SUCCESS (0.000s) [236.189785] [084/162] (822s left) kms_addfb_basic (no-handle) [236.421650] Starting subtest: no-handle [236.424487] Subtest no-handle: SUCCESS (0.000s) [237.001645] [085/162] (821s left) kms_addfb_basic (size-max) [237.536976] Starting subtest: size-max [237.541497] Subtest size-max: SUCCESS (0.001s) [237.748640] [086/162] (821s left) kms_addfb_basic (small-bo) [238.326367] Starting subtest: small-bo [238.330310] Subtest small-bo: SUCCESS (0.000s) [238.545528] [087/162] (820s left) kms_addfb_basic (tile-pitch-mismatch) [238.768205] Starting subtest: tile-pitch-mismatch [238.771215] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [239.352375] [088/162] (820s left) kms_addfb_basic (too-high) [239.919544] Starting subtest: too-high [239.925956] Subtest too-high: SUCCESS (0.006s) [240.144066] [089/162] (819s left) kms_addfb_basic (too-wide) [240.749819] Starting subtest: too-wide [240.753199] Subtest too-wide: SUCCESS (0.000s) [240.974217] [090/162] (818s left) kms_addfb_basic (unused-handle) [241.201183] Starting subtest: unused-handle [241.205202] Subtest unused-handle: SUCCESS (0.000s) [241.723656] [091/162] (818s left) kms_addfb_basic (unused-modifier) [241.946658] Starting subtest: unused-modifier [241.950833] Subtest unused-modifier: SUCCESS (0.000s) [242.509903] [092/162] (817s left) kms_addfb_basic (unused-offsets) [242.815390] Starting subtest: unused-offsets [242.819187] Subtest unused-offsets: SUCCESS (0.000s) [243.355325] [093/162] (817s left) kms_addfb_basic (unused-pitches) [243.584238] Starting subtest: unused-pitches [243.588269] Subtest unused-pitches: SUCCESS (0.001s) [244.118663] [094/162] (816s left) kms_busy (basic) [244.765359] Subtest basic: SKIP (0.000s) [244.975535] [095/162] (815s left) kms_prop_blob (basic) [245.201161] Starting subtest: basic [245.203399] Subtest basic: SUCCESS (0.000s) [245.401362] [096/162] (815s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [245.986336] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [246.190317] [097/162] (815s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [246.793477] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [246.996734] [098/162] (814s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [247.562159] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [247.820343] [099/162] (813s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [248.361416] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [248.555463] [100/162] (813s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [249.141106] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [249.348706] [101/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [249.965174] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [250.153580] [102/162] (812s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [250.790141] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [250.986549] [103/162] (811s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [251.597696] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [251.813364] [104/162] (811s left) kms_dsc (dsc-basic) [252.421673] Subtest dsc-basic: SKIP (0.000s) [252.636294] [105/162] (810s left) kms_flip (basic-flip-vs-dpms) [253.207186] Starting subtest: basic-flip-vs-dpms [253.227192] Subtest basic-flip-vs-dpms: SKIP (0.008s) [253.507547] [106/162] (809s left) kms_flip (basic-flip-vs-modeset) [254.063456] Starting subtest: basic-flip-vs-modeset [254.076119] Subtest basic-flip-vs-modeset: SKIP (0.006s) [254.338181] [107/162] (809s left) kms_flip (basic-flip-vs-wf_vblank) [254.928865] Starting subtest: basic-flip-vs-wf_vblank [254.960647] Subtest basic-flip-vs-wf_vblank: SKIP (0.017s) [255.241211] [108/162] (808s left) kms_flip (basic-plain-flip) [255.838159] Starting subtest: basic-plain-flip [255.854127] Subtest basic-plain-flip: SKIP (0.009s) [256.125362] [109/162] (807s left) kms_force_connector_basic (force-connector-state) [256.515256] Starting subtest: force-connector-state [257.331293] Subtest force-connector-state: SUCCESS (0.808s) [258.468768] [110/162] (805s left) kms_force_connector_basic (force-edid) [258.852887] Starting subtest: force-edid [259.153344] Subtest force-edid: SUCCESS (0.297s) [259.784424] [111/162] (804s left) kms_force_connector_basic (force-load-detect) [260.136857] Starting subtest: force-load-detect [260.144547] Subtest force-load-detect: SKIP (0.000s) [260.666375] [112/162] (803s left) kms_force_connector_basic (prune-stale-modes) [261.042245] Starting subtest: prune-stale-modes [261.376171] Subtest prune-stale-modes: SUCCESS (0.339s) [261.967657] [113/162] (802s left) kms_frontbuffer_tracking (basic) [262.497234] Subtest basic: SKIP (0.000s) [262.802736] [114/162] (802s left) kms_hdmi_inject (inject-audio) [263.056750] Starting subtest: inject-audio [263.525165] Subtest inject-audio: SUCCESS (0.443s) [264.037887] [115/162] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [264.581703] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [264.805301] [116/162] (800s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [265.387519] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [265.612545] [117/162] (800s left) kms_pipe_crc_basic (hang-read-crc) [266.218161] Subtest hang-read-crc: SKIP (0.000s) [266.444108] [118/162] (799s left) kms_pipe_crc_basic (nonblocking-crc) [267.008136] Subtest nonblocking-crc: SKIP (0.000s) [267.231161] [119/162] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [267.828153] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [268.063665] [120/162] (798s left) kms_pipe_crc_basic (read-crc) [268.652979] Subtest read-crc: SKIP (0.000s) [268.880617] [121/162] (797s left) kms_pipe_crc_basic (read-crc-frame-sequence) [269.468640] Subtest read-crc-frame-sequence: SKIP (0.000s) [269.704624] [122/162] (797s left) kms_pm_backlight (basic-brightness) [270.303910] Subtest basic-brightness: SKIP (0.000s) [270.529507] [123/162] (796s left) kms_pm_rpm (basic-pci-d3-state) [272.392135] Starting subtest: basic-pci-d3-state [272.616203] Subtest basic-pci-d3-state: SUCCESS (0.218s) [272.828598] [124/162] (794s left) kms_pm_rpm (basic-rte) [273.052854] Starting subtest: basic-rte [274.889303] Subtest basic-rte: SUCCESS (1.837s) [275.353862] [125/162] (792s left) kms_psr (psr-primary-page-flip) [275.979495] Subtest psr-primary-page-flip: SKIP (0.000s) [276.202423] [126/162] (791s left) kms_psr (psr-cursor-plane-move) [276.734301] Subtest psr-cursor-plane-move: SKIP (0.000s) [276.952453] [127/162] (790s left) kms_psr (psr-sprite-plane-onoff) [277.516255] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [277.784864] [128/162] (790s left) kms_psr (psr-primary-mmap-gtt) [278.345428] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [278.577747] [129/162] (789s left) kms_setmode (basic-clone-single-crtc) [278.825142] Starting subtest: basic-clone-single-crtc [278.833473] Subtest basic-clone-single-crtc: SKIP (0.003s) [279.070687] [130/162] (789s left) i915_pm_rps (basic-api) [279.338188] Starting subtest: basic-api [279.357429] Subtest basic-api: SUCCESS (0.018s) [279.585529] [131/162] (789s left) prime_self_import (basic-llseek-bad) [279.811855] Starting subtest: basic-llseek-bad [279.836473] Subtest basic-llseek-bad: SUCCESS (0.023s) [280.071860] [132/162] (788s left) prime_self_import (basic-llseek-size) [280.299313] Starting subtest: basic-llseek-size [280.312896] Subtest basic-llseek-size: SUCCESS (0.019s) [280.548643] [133/162] (788s left) prime_self_import (basic-with_fd_dup) [280.768624] Starting subtest: basic-with_fd_dup [280.793525] Subtest basic-with_fd_dup: SUCCESS (0.024s) [281.032599] [134/162] (788s left) prime_self_import (basic-with_one_bo) [281.253406] Starting subtest: basic-with_one_bo [281.268264] Subtest basic-with_one_bo: SUCCESS (0.017s) [281.511951] [135/162] (788s left) prime_self_import (basic-with_one_bo_two_files) [281.734114] Starting subtest: basic-with_one_bo_two_files [281.760758] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s) [281.993391] [136/162] (787s left) prime_self_import (basic-with_two_bos) [282.207907] Starting subtest: basic-with_two_bos [282.225187] Subtest basic-with_two_bos: SUCCESS (0.018s) [282.475765] [137/162] (787s left) prime_vgem (basic-fence-flip) [282.736819] Starting subtest: basic-fence-flip [283.058454] Subtest basic-fence-flip: SKIP (0.318s) [283.301167] [138/162] (786s left) prime_vgem (basic-fence-mmap) [283.584242] Starting subtest: basic-fence-mmap [283.719326] Subtest basic-fence-mmap: SUCCESS (0.141s) [283.965313] [139/162] (786s left) prime_vgem (basic-fence-read) [284.305053] Starting subtest: basic-fence-read [284.591744] Subtest basic-fence-read: SUCCESS (0.291s) [284.838344] [140/162] (785s left) prime_vgem (basic-gtt) [285.104837] Starting subtest: basic-gtt [285.175870] Subtest basic-gtt: SUCCESS (0.063s) [285.408215] [141/162] (785s left) prime_vgem (basic-read) [285.662229] Starting subtest: basic-read [285.803142] Subtest basic-read: SUCCESS (0.130s) [286.039472] [142/162] (785s left) prime_vgem (basic-write) [286.305285] Starting subtest: basic-write [286.474146] Subtest basic-write: SUCCESS (0.169s) [286.743795] [143/162] (784s left) vgem_basic (setversion) [286.985818] Starting subtest: setversion [286.996157] Subtest setversion: SUCCESS (0.000s) [287.217939] [144/162] (784s left) vgem_basic (create) [287.453549] Starting subtest: create [287.456906] Subtest create: SUCCESS (0.001s) [287.679766] [145/162] (784s left) vgem_basic (debugfs) [287.910188] Starting subtest: debugfs [287.914170] Subtest debugfs: SUCCESS (0.002s) [288.125857] [146/162] (783s left) vgem_basic (dmabuf-export) [288.351895] Starting subtest: dmabuf-export [288.374156] Subtest dmabuf-export: SUCCESS (0.021s) [288.616126] [147/162] (783s left) vgem_basic (dmabuf-fence) [288.845566] Starting subtest: dmabuf-fence [288.848172] Subtest dmabuf-fence: SUCCESS (0.004s) [289.063477] [148/162] (783s left) vgem_basic (dmabuf-fence-before) [289.300257] Starting subtest: dmabuf-fence-before [289.306779] Subtest dmabuf-fence-before: SUCCESS (0.002s) [289.516589] [149/162] (783s left) vgem_basic (dmabuf-mmap) [289.749966] Starting subtest: dmabuf-mmap [289.790163] Subtest dmabuf-mmap: SUCCESS (0.044s) [290.009551] [150/162] (782s left) vgem_basic (mmap) [290.237576] Starting subtest: mmap [290.269265] Subtest mmap: SUCCESS (0.033s) [290.494629] [151/162] (782s left) vgem_basic (second-client) [290.715941] Starting subtest: second-client [290.737258] Subtest second-client: SUCCESS (0.020s) [290.961651] [152/162] (782s left) vgem_basic (sysfs) [291.193137] Starting subtest: sysfs [291.196779] Subtest sysfs: SUCCESS (0.003s) [291.421357] [153/162] (781s left) core_hotunplug (unbind-rebind) [291.847249] Starting subtest: unbind-rebind [297.245370] Subtest unbind-rebind: SUCCESS (5.394s) [297.463979] [154/162] (776s left) vgem_basic (unload) [297.688138] Starting subtest: unload [326.988459] Subtest unload: SUCCESS (29.300s) [327.335225] [155/162] (746s left) i915_module_load (reload) [327.551225] Starting subtest: reload [335.212297] Subtest reload: SUCCESS (7.661s) [335.707325] [156/162] (738s left) gem_lmem_swapping (basic) [335.996126] Subtest basic: SKIP (0.000s) [336.215780] [157/162] (738s left) gem_lmem_swapping (parallel-random-engines) [336.490675] Subtest parallel-random-engines: SKIP (0.000s) [336.694456] [158/162] (738s left) gem_lmem_swapping (random-engines) [336.938634] Subtest random-engines: SKIP (0.000s) [337.162908] [159/162] (737s left) gem_lmem_swapping (verify-random) [337.404415] Subtest verify-random: SKIP (0.000s) [337.615801] [160/162] (737s left) i915_pm_rpm (module-reload) [339.556527] Starting subtest: module-reload [358.171557] Subtest module-reload: SUCCESS (18.618s) [358.314721] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [358.320435] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [358.327443] [161/162] (717s left) i915_selftest (live) [358.578119] Starting subtest: live [358.581535] Starting dynamic subtest: sanitycheck [364.764593] Dynamic subtest sanitycheck: SUCCESS (6.183s) [364.803686] Starting dynamic subtest: uncore [370.760276] Dynamic subtest uncore: SUCCESS (5.989s) [370.849796] Starting dynamic subtest: workarounds [377.149457] Dynamic subtest workarounds: SUCCESS (6.382s) [377.185939] Starting dynamic subtest: gt_engines [383.871988] Dynamic subtest gt_engines: SUCCESS (6.715s) [383.909645] Starting dynamic subtest: gt_timelines [422.713406] Dynamic subtest gt_timelines: SUCCESS (38.832s) [422.746983] Starting dynamic subtest: gt_contexts [429.051546] Dynamic subtest gt_contexts: SUCCESS (6.334s) [429.083839] Starting dynamic subtest: gt_lrc [438.511873] Dynamic subtest gt_lrc: SUCCESS (9.456s) [438.545957] Starting dynamic subtest: gt_mocs [444.644944] Dynamic subtest gt_mocs: SUCCESS (6.129s) [444.689406] Starting dynamic subtest: gt_pm [451.789189] Dynamic subtest gt_pm: SUCCESS (7.127s) [451.822355] Starting dynamic subtest: gt_heartbeat [457.734701] Dynamic subtest gt_heartbeat: SUCCESS (5.946s) [457.878166] Starting dynamic subtest: gt_tlb [464.406647] Dynamic subtest gt_tlb: SUCCESS (6.662s) [464.445426] Starting dynamic subtest: requests [477.326948] Dynamic subtest requests: SUCCESS (12.913s) [477.364318] Starting dynamic subtest: migrate [488.036449] Dynamic subtest migrate: SUCCESS (10.701s) [488.119278] Starting dynamic subtest: active [494.432092] Dynamic subtest active: SUCCESS (6.383s) [494.474235] Starting dynamic subtest: objects [502.133566] Dynamic subtest objects: SUCCESS (7.689s) [502.167601] Starting dynamic subtest: mman [515.133443] Dynamic subtest mman: SUCCESS (12.994s) [515.169121] Starting dynamic subtest: dmabuf [521.409204] Dynamic subtest dmabuf: SUCCESS (6.272s) [521.448280] Starting dynamic subtest: vma [527.703833] Dynamic subtest vma: SUCCESS (6.286s) [527.745453] Starting dynamic subtest: coherency [539.425535] Dynamic subtest coherency: SUCCESS (11.716s) [539.505291] Starting dynamic subtest: gtt [553.660492] Dynamic subtest gtt: SUCCESS (14.228s) [553.698981] Starting dynamic subtest: gem [561.179806] Dynamic subtest gem: SUCCESS (7.513s) [561.218398] Starting dynamic subtest: evict [575.842278] Dynamic subtest evict: SUCCESS (14.655s) [575.882376] Starting dynamic subtest: hugepages [582.252331] Dynamic subtest hugepages: SUCCESS (6.403s) [582.294709] Starting dynamic subtest: gem_contexts [617.269842] Dynamic subtest gem_contexts: SUCCESS (35.006s) [617.309370] Starting dynamic subtest: client [623.228500] Dynamic subtest client: SUCCESS (5.950s) [623.317480] Starting dynamic subtest: gem_migrate [630.169976] Dynamic subtest gem_migrate: SUCCESS (6.928s) [630.210806] Starting dynamic subtest: reset [644.594391] Dynamic subtest reset: SUCCESS (14.416s) [644.629863] Starting dynamic subtest: memory_region [650.614196] Dynamic subtest memory_region: SUCCESS (6.011s) [650.651891] Starting dynamic subtest: hangcheck [680.297811] Dynamic subtest hangcheck: SUCCESS (29.680s) [680.338251] Starting dynamic subtest: execlists [692.962745] Dynamic subtest execlists: SUCCESS (12.657s) [693.016451] Starting dynamic subtest: ring_submission [699.679143] Dynamic subtest ring_submission: SUCCESS (6.699s) [699.784224] Starting dynamic subtest: perf [706.215531] Dynamic subtest perf: SUCCESS (6.530s) [706.258340] Starting dynamic subtest: slpc [712.117214] Dynamic subtest slpc: SUCCESS (5.892s) [712.169861] Starting dynamic subtest: guc [718.213041] Dynamic subtest guc: SUCCESS (6.078s) [718.252760] Starting dynamic subtest: guc_multi_lrc [724.242143] Dynamic subtest guc_multi_lrc: SUCCESS (6.025s) [724.283346] Starting dynamic subtest: guc_hang [730.274819] Dynamic subtest guc_hang: SUCCESS (6.026s) [730.322251] Starting dynamic subtest: late_gt_pm [736.616531] Dynamic subtest late_gt_pm: SUCCESS (6.331s) [736.622191] Subtest live: SUCCESS (378.031s) [736.792636] [162/162] (338s left) dmabuf (all-tests) [737.033907] Starting subtest: all-tests [737.036258] Starting dynamic subtest: sanitycheck [737.115073] Dynamic subtest sanitycheck: SUCCESS (0.083s) [737.196101] Starting dynamic subtest: dma_fence [737.336275] Dynamic subtest dma_fence: SUCCESS (0.206s) [737.408733] Starting dynamic subtest: dma_fence_chain [737.413686] Dynamic subtest dma_fence_chain: SKIP (0.001s) [737.452187] Starting dynamic subtest: dma_fence_unwrap [737.454198] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s) [737.500797] Starting dynamic subtest: dma_resv [737.522992] Dynamic subtest dma_resv: SUCCESS (0.090s) [737.531139] Subtest all-tests: SUCCESS (0.498s) [737.682511] 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.