[76.782318] Initializing watchdogs [76.782692] /dev/watchdog0 [76.898417] [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 [76.931792] [001/162] (960s left) i915_module_load (load) [77.222976] Starting subtest: load [82.815204] Subtest load: SUCCESS (5.581s) [83.225788] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [83.239520] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [83.250708] [002/162] (954s left) core_auth (basic-auth) [83.516463] Starting subtest: basic-auth [83.519732] Subtest basic-auth: SUCCESS (0.006s) [83.720310] [003/162] (954s left) core_debugfs (read-all-entries) [83.955259] Starting subtest: read-all-entries [83.967152] Subtest read-all-entries: SUCCESS (0.014s) [84.143196] [004/162] (953s left) core_sysfs (read-all-entries) [84.381718] Starting subtest: read-all-entries [84.396564] Subtest read-all-entries: SUCCESS (0.019s) [84.571507] [005/162] (953s left) fbdev (eof) [84.848186] Subtest eof: SKIP (0.000s) [85.018652] [006/162] (953s left) fbdev (info) [85.299888] Subtest info: SKIP (0.000s) [85.470643] [007/162] (953s left) fbdev (nullptr) [85.831678] Subtest nullptr: SKIP (0.000s) [86.091931] [008/162] (952s left) fbdev (read) [86.374187] Subtest read: SKIP (0.000s) [86.572808] [009/162] (952s left) fbdev (write) [86.852693] Subtest write: SKIP (0.000s) [87.014437] [010/162] (952s left) gem_basic (bad-close) [87.244244] Starting subtest: bad-close [87.250327] Subtest bad-close: SUCCESS (0.000s) [87.429740] [011/162] (952s left) gem_basic (create-close) [87.662825] Starting subtest: create-close [87.669531] Subtest create-close: SUCCESS (0.000s) [87.853492] [012/162] (951s left) gem_basic (create-fd-close) [88.084861] Starting subtest: create-fd-close [88.088952] Subtest create-fd-close: SUCCESS (0.002s) [88.263417] [013/162] (951s left) gem_busy (busy@all-engines) [88.562686] Starting subtest: busy [88.565843] Starting dynamic subtest: all-engines [88.742802] Dynamic subtest all-engines: SUCCESS (0.181s) [88.746172] Subtest busy: SUCCESS (0.187s) [89.255947] [014/162] (950s left) gem_close_race (basic-process) [89.553092] Starting subtest: basic-process [89.688802] Subtest basic-process: SUCCESS (0.137s) [90.000699] [015/162] (950s left) gem_close_race (basic-threads) [90.293397] Starting subtest: basic-threads [91.605674] Subtest basic-threads: SUCCESS (1.319s) [91.932955] [016/162] (948s left) gem_ctx_create (basic) [92.226282] Starting subtest: basic [92.229169] Subtest basic: SUCCESS (0.000s) [92.534790] [017/162] (948s left) gem_ctx_create (basic-files) [92.809177] Starting subtest: basic-files [94.873732] Subtest basic-files: SUCCESS (2.066s) [95.225931] [018/162] (945s left) gem_ctx_exec (basic) [95.466700] Starting subtest: basic [95.485065] Subtest basic: SUCCESS (0.016s) [95.679469] [019/162] (945s left) gem_exec_basic (basic) [95.933889] Starting subtest: basic [95.937600] Starting dynamic subtest: rcs0-smem [95.940580] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [95.981223] Starting dynamic subtest: bcs0-smem [95.984272] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [96.011519] Starting dynamic subtest: vcs0-smem [96.013300] Dynamic subtest vcs0-smem: SUCCESS (0.004s) [96.040166] Starting dynamic subtest: vecs0-smem [96.042574] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [96.044335] Subtest basic: SUCCESS (0.027s) [96.279233] [020/162] (944s left) gem_exec_create (basic) [96.552956] Starting subtest: basic [96.557023] Starting dynamic subtest: smem [98.644087] Dynamic subtest smem: SUCCESS (2.086s) [98.647296] Subtest basic: SUCCESS (2.088s) [98.957598] [021/162] (942s left) gem_exec_fence (basic-busy) [99.396639] Starting subtest: basic-busy [99.401110] Starting dynamic subtest: rcs0 [99.434320] Dynamic subtest rcs0: SUCCESS (0.037s) [99.464515] Starting dynamic subtest: bcs0 [99.473607] Dynamic subtest bcs0: SUCCESS (0.040s) [99.504737] Starting dynamic subtest: vcs0 [99.511574] Dynamic subtest vcs0: SUCCESS (0.037s) [99.542797] Starting dynamic subtest: vecs0 [99.550377] Dynamic subtest vecs0: SUCCESS (0.035s) [99.552098] Subtest basic-busy: SUCCESS (0.155s) [100.530549] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [100.537272] [022/162] (940s left) gem_exec_fence (basic-wait) [100.973793] Starting subtest: basic-wait [100.977278] Starting dynamic subtest: rcs0 [101.011145] Dynamic subtest rcs0: SUCCESS (0.032s) [101.064083] Starting dynamic subtest: bcs0 [101.066751] Dynamic subtest bcs0: SUCCESS (0.029s) [101.100386] Starting dynamic subtest: vcs0 [101.102956] Dynamic subtest vcs0: SUCCESS (0.035s) [101.133892] Starting dynamic subtest: vecs0 [101.135630] Dynamic subtest vecs0: SUCCESS (0.031s) [101.137504] Subtest basic-wait: SUCCESS (0.137s) [101.913748] [023/162] (939s left) gem_exec_fence (basic-await) [102.357292] Starting subtest: basic-await [102.362221] Starting dynamic subtest: rcs0 [102.561171] Dynamic subtest rcs0: SUCCESS (0.201s) [102.590466] Starting dynamic subtest: bcs0 [102.753881] Dynamic subtest bcs0: SUCCESS (0.189s) [102.784983] Starting dynamic subtest: vcs0 [102.943962] Dynamic subtest vcs0: SUCCESS (0.188s) [102.973409] Starting dynamic subtest: vecs0 [103.141980] Dynamic subtest vecs0: SUCCESS (0.195s) [103.144473] Subtest basic-await: SUCCESS (0.786s) [103.946928] [024/162] (937s left) gem_exec_fence (nb-await) [104.412486] Starting subtest: nb-await [104.420450] Starting dynamic subtest: rcs0 [104.498679] Dynamic subtest rcs0: SUCCESS (0.109s) [104.542247] Starting dynamic subtest: bcs0 [104.615231] Dynamic subtest bcs0: SUCCESS (0.112s) [104.651460] Starting dynamic subtest: vcs0 [104.716957] Dynamic subtest vcs0: SUCCESS (0.091s) [104.752769] Starting dynamic subtest: vecs0 [104.807327] Dynamic subtest vecs0: SUCCESS (0.090s) [104.809251] Subtest nb-await: SUCCESS (0.419s) [105.609703] [025/162] (936s left) gem_exec_gttfill (basic) [105.881488] Starting subtest: basic [138.557248] Subtest basic: SUCCESS (32.671s) [138.920556] [026/162] (903s left) gem_exec_parallel (engines) [139.395485] Starting subtest: engines [139.399205] Starting dynamic subtest: basic [147.704389] Dynamic subtest basic: SUCCESS (8.310s) [147.740890] Starting dynamic subtest: contexts [158.655958] Dynamic subtest contexts: SUCCESS (10.943s) [158.696186] Starting dynamic subtest: fds [171.381438] Dynamic subtest fds: SUCCESS (12.724s) [171.440464] Starting dynamic subtest: userptr [178.103881] Dynamic subtest userptr: SUCCESS (6.725s) [178.106520] Subtest engines: SUCCESS (38.716s) [178.490795] [027/162] (864s left) gem_exec_store (basic) [178.763844] Starting subtest: basic [178.846450] Subtest basic: SUCCESS (0.087s) [179.181367] [028/162] (863s left) gem_flink_basic (bad-flink) [179.422670] Starting subtest: bad-flink [179.426757] Subtest bad-flink: SUCCESS (0.000s) [179.628978] [029/162] (863s left) gem_flink_basic (bad-open) [179.859694] Starting subtest: bad-open [179.862402] Subtest bad-open: SUCCESS (0.000s) [180.071717] [030/162] (863s left) gem_flink_basic (basic) [180.284485] Starting subtest: basic [180.287211] Subtest basic: SUCCESS (0.000s) [180.495695] [031/162] (862s left) gem_flink_basic (double-flink) [180.720506] Starting subtest: double-flink [180.722516] Subtest double-flink: SUCCESS (0.000s) [180.939494] [032/162] (862s left) gem_flink_basic (flink-lifetime) [181.169258] Starting subtest: flink-lifetime [181.179201] Subtest flink-lifetime: SUCCESS (0.008s) [181.397237] [033/162] (862s left) gem_huc_copy (huc-copy) [181.653226] Subtest huc-copy: SKIP (0.000s) [181.860194] [034/162] (862s left) gem_linear_blits (basic) [182.487795] Starting subtest: basic [182.524245] Subtest basic: SUCCESS (0.041s) [182.770288] [035/162] (861s left) gem_mmap (basic) [183.158669] Starting subtest: basic [183.174318] Subtest basic: SUCCESS (0.001s) [183.375634] [036/162] (861s left) gem_mmap_gtt (basic) [183.604975] Starting subtest: basic [183.616239] Subtest basic: SUCCESS (0.005s) [183.821305] [037/162] (860s left) gem_render_linear_blits (basic) [184.071301] Starting subtest: basic [184.197286] Subtest basic: SUCCESS (0.119s) [184.406382] [038/162] (860s left) gem_render_tiled_blits (basic) [184.653199] Starting subtest: basic [184.842947] Subtest basic: SUCCESS (0.183s) [185.056537] [039/162] (860s left) gem_ringfill (basic-all) [185.560151] Starting subtest: basic-all [186.961877] Subtest basic-all: SUCCESS (1.396s) [187.194456] [040/162] (858s left) gem_softpin (allocator-basic) [187.443402] Starting subtest: allocator-basic [187.864152] Subtest allocator-basic: SUCCESS (0.420s) [188.122278] [041/162] (857s left) gem_softpin (allocator-basic-reserve) [188.376076] Starting subtest: allocator-basic-reserve [188.809403] Subtest allocator-basic-reserve: SUCCESS (0.428s) [189.063067] [042/162] (856s left) gem_softpin (safe-alignment) [189.312936] Starting subtest: safe-alignment [189.366846] Subtest safe-alignment: SUCCESS (0.047s) [189.586442] [043/162] (856s left) gem_sync (basic-all) [189.857171] Starting subtest: basic-all [193.317787] Subtest basic-all: SUCCESS (3.460s) [193.656928] [044/162] (852s left) gem_sync (basic-each) [193.935167] Starting subtest: basic-each [196.779229] Subtest basic-each: SUCCESS (2.842s) [197.134881] [045/162] (849s left) gem_tiled_blits (basic) [197.603478] Starting subtest: basic [197.694557] Subtest basic: SUCCESS (0.087s) [197.944421] [046/162] (848s left) gem_tiled_fence_blits (basic) [198.585638] Starting subtest: basic [198.654775] Subtest basic: SUCCESS (0.067s) [198.895892] [047/162] (847s left) gem_tiled_pread_basic (basic) [199.279343] Starting subtest: basic [200.427455] Subtest basic: SUCCESS (1.144s) [200.635543] [048/162] (846s left) gem_wait (busy@all-engines) [200.932975] Starting subtest: busy [200.937143] Starting dynamic subtest: all-engines [201.482815] Dynamic subtest all-engines: SUCCESS (0.542s) [201.485816] Subtest busy: SUCCESS (0.544s) [201.915643] [049/162] (845s left) gem_wait (wait@all-engines) [202.216561] Starting subtest: wait [202.219323] Starting dynamic subtest: all-engines [203.273194] Dynamic subtest all-engines: SUCCESS (1.052s) [203.280119] Subtest wait: SUCCESS (1.054s) [203.689369] [050/162] (843s left) i915_getparams_basic (basic-eu-total) [203.923517] Starting subtest: basic-eu-total [203.928043] Subtest basic-eu-total: SUCCESS (0.000s) [204.134545] [051/162] (843s left) i915_getparams_basic (basic-subslice-total) [204.357286] Starting subtest: basic-subslice-total [204.364176] Subtest basic-subslice-total: SUCCESS (0.000s) [204.556700] [052/162] (843s left) i915_hangman (error-state-basic) [204.830107] Starting subtest: error-state-basic [204.875112] Subtest error-state-basic: SUCCESS (0.032s) [205.151467] [053/162] (842s left) i915_pciid [205.595331] [054/162] (842s left) intel_hwmon (hwmon-read) [205.823135] Subtest hwmon-read: SKIP (0.000s) [206.020529] [055/162] (842s left) intel_hwmon (hwmon-write) [206.247141] Subtest hwmon-write: SKIP (0.000s) [206.473866] [056/162] (842s left) kms_addfb_basic (addfb25-4-tiled) [207.183685] Starting subtest: addfb25-4-tiled [207.187990] Subtest addfb25-4-tiled: SUCCESS (0.002s) [207.397875] [057/162] (841s left) kms_addfb_basic (addfb25-bad-modifier) [207.916411] Starting subtest: addfb25-bad-modifier [207.918657] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [208.143286] [058/162] (841s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [208.747592] Starting subtest: addfb25-framebuffer-vs-set-tiling [208.750192] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [208.967487] [059/162] (840s left) kms_addfb_basic (addfb25-modifier-no-flag) [209.562738] Starting subtest: addfb25-modifier-no-flag [209.566829] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [209.778626] [060/162] (839s left) kms_addfb_basic (addfb25-x-tiled-legacy) [210.361754] Starting subtest: addfb25-x-tiled-legacy [210.365495] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [210.578840] [061/162] (839s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [211.195592] Starting subtest: addfb25-x-tiled-mismatch-legacy [211.201430] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s) [211.414427] [062/162] (838s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [212.122193] Starting subtest: addfb25-yf-tiled-legacy [212.124951] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.004s) [212.375903] [063/162] (837s left) kms_addfb_basic (addfb25-y-tiled-legacy) [212.983784] Starting subtest: addfb25-y-tiled-legacy [212.986262] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s) [213.204288] [064/162] (837s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [213.767628] Starting subtest: addfb25-y-tiled-small-legacy [213.773926] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [213.982316] [065/162] (836s left) kms_addfb_basic (bad-pitch-0) [214.199265] Starting subtest: bad-pitch-0 [214.203146] Subtest bad-pitch-0: SUCCESS (0.000s) [214.780533] [066/162] (836s left) kms_addfb_basic (bad-pitch-1024) [215.013184] Starting subtest: bad-pitch-1024 [215.016332] Subtest bad-pitch-1024: SUCCESS (0.000s) [215.542503] [067/162] (835s left) kms_addfb_basic (bad-pitch-128) [215.772203] Starting subtest: bad-pitch-128 [215.774306] Subtest bad-pitch-128: SUCCESS (0.000s) [216.292221] [068/162] (834s left) kms_addfb_basic (bad-pitch-256) [216.530449] Starting subtest: bad-pitch-256 [216.535239] Subtest bad-pitch-256: SUCCESS (0.000s) [217.161550] [069/162] (834s left) kms_addfb_basic (bad-pitch-32) [217.383563] Starting subtest: bad-pitch-32 [217.386655] Subtest bad-pitch-32: SUCCESS (0.000s) [217.918256] [070/162] (833s left) kms_addfb_basic (bad-pitch-63) [218.143518] Starting subtest: bad-pitch-63 [218.148397] Subtest bad-pitch-63: SUCCESS (0.000s) [218.700898] [071/162] (833s left) kms_addfb_basic (bad-pitch-65536) [218.943367] Starting subtest: bad-pitch-65536 [218.947225] Subtest bad-pitch-65536: SUCCESS (0.002s) [219.481176] [072/162] (832s left) kms_addfb_basic (bad-pitch-999) [219.700672] Starting subtest: bad-pitch-999 [219.705217] Subtest bad-pitch-999: SUCCESS (0.000s) [220.300780] [073/162] (832s left) kms_addfb_basic (basic) [220.534232] Starting subtest: basic [220.536374] Subtest basic: SUCCESS (0.000s) [221.070401] [074/162] (831s left) kms_addfb_basic (basic-x-tiled-legacy) [221.304823] Starting subtest: basic-x-tiled-legacy [221.309160] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [221.863311] [075/162] (830s left) kms_addfb_basic (basic-y-tiled-legacy) [222.106128] Starting subtest: basic-y-tiled-legacy [222.108270] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [222.637825] [076/162] (830s left) kms_addfb_basic (bo-too-small) [223.177578] Starting subtest: bo-too-small [223.179998] Subtest bo-too-small: SUCCESS (0.003s) [223.403750] [077/162] (829s left) kms_addfb_basic (bo-too-small-due-to-tiling) [223.953188] Starting subtest: bo-too-small-due-to-tiling [223.957298] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [224.176311] [078/162] (829s left) kms_addfb_basic (clobberred-modifier) [224.408668] Starting subtest: clobberred-modifier [224.411380] Subtest clobberred-modifier: SUCCESS (0.001s) [224.976171] [079/162] (828s left) kms_addfb_basic (framebuffer-vs-set-tiling) [225.208455] Starting subtest: framebuffer-vs-set-tiling [225.212278] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [225.720629] [080/162] (828s left) kms_addfb_basic (invalid-get-prop) [225.941188] Starting subtest: invalid-get-prop [225.945199] Subtest invalid-get-prop: SUCCESS (0.000s) [226.510156] [081/162] (827s left) kms_addfb_basic (invalid-get-prop-any) [226.742276] Starting subtest: invalid-get-prop-any [226.746164] Subtest invalid-get-prop-any: SUCCESS (0.000s) [227.454810] [082/162] (826s left) kms_addfb_basic (invalid-set-prop) [227.686703] Starting subtest: invalid-set-prop [227.689491] Subtest invalid-set-prop: SUCCESS (0.000s) [228.274563] [083/162] (826s left) kms_addfb_basic (invalid-set-prop-any) [228.496194] Starting subtest: invalid-set-prop-any [228.500165] Subtest invalid-set-prop-any: SUCCESS (0.000s) [229.034572] [084/162] (825s left) kms_addfb_basic (no-handle) [229.261817] Starting subtest: no-handle [229.266186] Subtest no-handle: SUCCESS (0.000s) [229.804455] [085/162] (825s left) kms_addfb_basic (size-max) [230.382416] Starting subtest: size-max [230.385575] Subtest size-max: SUCCESS (0.001s) [230.597751] [086/162] (824s left) kms_addfb_basic (small-bo) [231.173451] Starting subtest: small-bo [231.176563] Subtest small-bo: SUCCESS (0.000s) [231.387592] [087/162] (823s left) kms_addfb_basic (tile-pitch-mismatch) [231.632718] Starting subtest: tile-pitch-mismatch [231.638176] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [232.193529] [088/162] (823s left) kms_addfb_basic (too-high) [232.774409] Starting subtest: too-high [232.782324] Subtest too-high: SUCCESS (0.007s) [233.000629] [089/162] (822s left) kms_addfb_basic (too-wide) [233.554379] Starting subtest: too-wide [233.558875] Subtest too-wide: SUCCESS (0.001s) [233.771256] [090/162] (822s left) kms_addfb_basic (unused-handle) [234.004478] Starting subtest: unused-handle [234.007454] Subtest unused-handle: SUCCESS (0.000s) [234.565335] [091/162] (821s left) kms_addfb_basic (unused-modifier) [234.793434] Starting subtest: unused-modifier [234.799166] Subtest unused-modifier: SUCCESS (0.000s) [235.405645] [092/162] (820s left) kms_addfb_basic (unused-offsets) [235.632344] Starting subtest: unused-offsets [235.636644] Subtest unused-offsets: SUCCESS (0.000s) [236.170568] [093/162] (820s left) kms_addfb_basic (unused-pitches) [236.401430] Starting subtest: unused-pitches [236.405151] Subtest unused-pitches: SUCCESS (0.000s) [236.906669] [094/162] (819s left) kms_busy (basic) [237.475297] Subtest basic: SKIP (0.000s) [237.687547] [095/162] (819s left) kms_prop_blob (basic) [237.920695] Starting subtest: basic [237.924259] Subtest basic: SUCCESS (0.000s) [238.124737] [096/162] (819s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [238.700214] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [238.906637] [097/162] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [239.469634] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [239.668423] [098/162] (818s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [240.306094] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [240.504973] [099/162] (817s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [241.061108] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [241.262589] [100/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [241.923284] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [242.187894] [101/162] (816s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [242.772423] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [242.961639] [102/162] (815s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [243.541762] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [243.730776] [103/162] (815s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [244.309689] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [244.505158] [104/162] (814s left) kms_dsc (dsc-basic) [245.118194] Subtest dsc-basic: SKIP (0.000s) [245.327618] [105/162] (813s left) kms_flip (basic-flip-vs-dpms) [245.912173] Starting subtest: basic-flip-vs-dpms [245.921184] Subtest basic-flip-vs-dpms: SKIP (0.007s) [246.191090] [106/162] (813s left) kms_flip (basic-flip-vs-modeset) [246.801101] Starting subtest: basic-flip-vs-modeset [246.825175] Subtest basic-flip-vs-modeset: SKIP (0.007s) [247.075765] [107/162] (812s left) kms_flip (basic-flip-vs-wf_vblank) [247.641920] Starting subtest: basic-flip-vs-wf_vblank [247.651522] Subtest basic-flip-vs-wf_vblank: SKIP (0.009s) [247.974143] [108/162] (811s left) kms_flip (basic-plain-flip) [248.585818] Starting subtest: basic-plain-flip [248.593316] Subtest basic-plain-flip: SKIP (0.006s) [248.864988] [109/162] (811s left) kms_force_connector_basic (force-connector-state) [249.247158] Starting subtest: force-connector-state [249.948774] Subtest force-connector-state: SUCCESS (0.693s) [251.170439] [110/162] (809s left) kms_force_connector_basic (force-edid) [251.615988] Starting subtest: force-edid [251.991227] Subtest force-edid: SUCCESS (0.382s) [252.871145] [111/162] (807s left) kms_force_connector_basic (force-load-detect) [253.357189] Starting subtest: force-load-detect [253.365328] Subtest force-load-detect: SKIP (0.000s) [253.919582] [112/162] (807s left) kms_force_connector_basic (prune-stale-modes) [254.308960] Starting subtest: prune-stale-modes [254.631720] Subtest prune-stale-modes: SUCCESS (0.317s) [255.138762] [113/162] (806s left) kms_frontbuffer_tracking (basic) [255.712825] Subtest basic: SKIP (0.000s) [255.933687] [114/162] (805s left) kms_hdmi_inject (inject-audio) [256.180489] Starting subtest: inject-audio [256.711341] Subtest inject-audio: SUCCESS (0.534s) [257.347795] [115/162] (804s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [257.899797] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [258.121617] [116/162] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [258.663487] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [258.899454] [117/162] (803s left) kms_pipe_crc_basic (hang-read-crc) [259.523321] Subtest hang-read-crc: SKIP (0.000s) [259.753350] [118/162] (802s left) kms_pipe_crc_basic (nonblocking-crc) [260.350229] Subtest nonblocking-crc: SKIP (0.000s) [260.577084] [119/162] (801s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [261.106415] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [261.326485] [120/162] (801s left) kms_pipe_crc_basic (read-crc) [261.888458] Subtest read-crc: SKIP (0.000s) [262.118588] [121/162] (800s left) kms_pipe_crc_basic (read-crc-frame-sequence) [262.695392] Subtest read-crc-frame-sequence: SKIP (0.000s) [262.915244] [122/162] (800s left) kms_pm_backlight (basic-brightness) [263.485733] Subtest basic-brightness: SKIP (0.000s) [263.717463] [123/162] (799s left) kms_pm_rpm (basic-pci-d3-state) [265.544579] Starting subtest: basic-pci-d3-state [265.770275] Subtest basic-pci-d3-state: SUCCESS (0.229s) [266.000628] [124/162] (797s left) kms_pm_rpm (basic-rte) [266.227333] Starting subtest: basic-rte [267.993621] Subtest basic-rte: SUCCESS (1.763s) [268.451358] [125/162] (795s left) kms_psr (psr-primary-page-flip) [269.009253] Subtest psr-primary-page-flip: SKIP (0.000s) [269.235473] [126/162] (794s left) kms_psr (psr-cursor-plane-move) [269.805066] Subtest psr-cursor-plane-move: SKIP (0.000s) [270.030326] [127/162] (794s left) kms_psr (psr-sprite-plane-onoff) [270.547294] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [270.765685] [128/162] (793s left) kms_psr (psr-primary-mmap-gtt) [271.343848] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [271.570666] [129/162] (793s left) kms_setmode (basic-clone-single-crtc) [271.810870] Starting subtest: basic-clone-single-crtc [271.815831] Subtest basic-clone-single-crtc: SKIP (0.001s) [272.078438] [130/162] (792s left) i915_pm_rps (basic-api) [272.376151] Starting subtest: basic-api [272.396493] Subtest basic-api: SUCCESS (0.020s) [272.619683] [131/162] (792s left) prime_self_import (basic-llseek-bad) [272.830524] Starting subtest: basic-llseek-bad [272.851644] Subtest basic-llseek-bad: SUCCESS (0.021s) [273.095676] [132/162] (792s left) prime_self_import (basic-llseek-size) [273.315626] Starting subtest: basic-llseek-size [273.329716] Subtest basic-llseek-size: SUCCESS (0.016s) [273.577949] [133/162] (791s left) prime_self_import (basic-with_fd_dup) [273.804300] Starting subtest: basic-with_fd_dup [273.823691] Subtest basic-with_fd_dup: SUCCESS (0.021s) [274.065910] [134/162] (791s left) prime_self_import (basic-with_one_bo) [274.285221] Starting subtest: basic-with_one_bo [274.307305] Subtest basic-with_one_bo: SUCCESS (0.017s) [274.549485] [135/162] (791s left) prime_self_import (basic-with_one_bo_two_files) [274.770594] Starting subtest: basic-with_one_bo_two_files [274.790453] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s) [275.020540] [136/162] (791s left) prime_self_import (basic-with_two_bos) [275.245688] Starting subtest: basic-with_two_bos [275.264768] Subtest basic-with_two_bos: SUCCESS (0.024s) [275.508343] [137/162] (790s left) prime_vgem (basic-fence-flip) [275.768071] Starting subtest: basic-fence-flip [276.084153] Subtest basic-fence-flip: SKIP (0.315s) [276.325801] [138/162] (790s left) prime_vgem (basic-fence-mmap) [276.602101] Starting subtest: basic-fence-mmap [276.744503] Subtest basic-fence-mmap: SUCCESS (0.141s) [276.991253] [139/162] (789s left) prime_vgem (basic-fence-read) [277.252635] Starting subtest: basic-fence-read [277.568355] Subtest basic-fence-read: SUCCESS (0.315s) [277.819854] [140/162] (789s left) prime_vgem (basic-gtt) [278.107057] Starting subtest: basic-gtt [278.168106] Subtest basic-gtt: SUCCESS (0.070s) [278.423889] [141/162] (788s left) prime_vgem (basic-read) [278.694137] Starting subtest: basic-read [278.825656] Subtest basic-read: SUCCESS (0.135s) [279.078477] [142/162] (788s left) prime_vgem (basic-write) [279.349264] Starting subtest: basic-write [279.523143] Subtest basic-write: SUCCESS (0.174s) [279.768243] [143/162] (787s left) vgem_basic (setversion) [280.001390] Starting subtest: setversion [280.007228] Subtest setversion: SUCCESS (0.001s) [280.225704] [144/162] (787s left) vgem_basic (create) [280.457266] Starting subtest: create [280.461345] Subtest create: SUCCESS (0.002s) [280.691382] [145/162] (787s left) vgem_basic (debugfs) [280.929836] Starting subtest: debugfs [280.933187] Subtest debugfs: SUCCESS (0.002s) [281.161655] [146/162] (787s left) vgem_basic (dmabuf-export) [281.399365] Starting subtest: dmabuf-export [281.425261] Subtest dmabuf-export: SUCCESS (0.022s) [281.671785] [147/162] (786s left) vgem_basic (dmabuf-fence) [281.903482] Starting subtest: dmabuf-fence [281.906195] Subtest dmabuf-fence: SUCCESS (0.004s) [282.127573] [148/162] (786s left) vgem_basic (dmabuf-fence-before) [282.361129] Starting subtest: dmabuf-fence-before [282.363698] Subtest dmabuf-fence-before: SUCCESS (0.003s) [282.586758] [149/162] (786s left) vgem_basic (dmabuf-mmap) [282.815310] Starting subtest: dmabuf-mmap [282.871869] Subtest dmabuf-mmap: SUCCESS (0.055s) [283.094993] [150/162] (786s left) vgem_basic (mmap) [283.336296] Starting subtest: mmap [283.363184] Subtest mmap: SUCCESS (0.030s) [283.591172] [151/162] (785s left) vgem_basic (second-client) [283.836482] Starting subtest: second-client [283.864787] Subtest second-client: SUCCESS (0.031s) [284.088599] [152/162] (785s left) vgem_basic (sysfs) [284.310967] Starting subtest: sysfs [284.329334] Subtest sysfs: SUCCESS (0.006s) [284.555516] [153/162] (785s left) core_hotunplug (unbind-rebind) [284.990206] Starting subtest: unbind-rebind [290.549201] Subtest unbind-rebind: SUCCESS (5.551s) [290.754245] [154/162] (779s left) vgem_basic (unload) [290.991516] Starting subtest: unload [320.183324] Subtest unload: SUCCESS (29.195s) [320.553758] [155/162] (749s left) i915_module_load (reload) [320.781678] Starting subtest: reload [328.353644] Subtest reload: SUCCESS (7.565s) [328.759249] [156/162] (741s left) gem_lmem_swapping (basic) [329.039882] Subtest basic: SKIP (0.000s) [329.244757] [157/162] (741s left) gem_lmem_swapping (parallel-random-engines) [329.494989] Subtest parallel-random-engines: SKIP (0.000s) [329.710548] [158/162] (741s left) gem_lmem_swapping (random-engines) [329.948192] Subtest random-engines: SKIP (0.000s) [330.158747] [159/162] (741s left) gem_lmem_swapping (verify-random) [330.411286] Subtest verify-random: SKIP (0.000s) [330.617806] [160/162] (740s left) i915_pm_rpm (module-reload) [332.563228] Starting subtest: module-reload [351.810939] Subtest module-reload: SUCCESS (19.248s) [351.958891] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [351.964741] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [351.971856] [161/162] (719s left) i915_selftest (live) [352.220829] Starting subtest: live [352.225299] Starting dynamic subtest: sanitycheck [358.174292] Dynamic subtest sanitycheck: SUCCESS (5.953s) [358.213418] Starting dynamic subtest: uncore [364.119142] Dynamic subtest uncore: SUCCESS (5.937s) [364.158786] Starting dynamic subtest: workarounds [370.439487] Dynamic subtest workarounds: SUCCESS (6.313s) [370.474210] Starting dynamic subtest: gt_engines [376.955792] Dynamic subtest gt_engines: SUCCESS (6.513s) [377.008218] Starting dynamic subtest: gt_timelines [415.146057] Dynamic subtest gt_timelines: SUCCESS (38.173s) [415.179991] Starting dynamic subtest: gt_contexts [421.309199] Dynamic subtest gt_contexts: SUCCESS (6.159s) [421.342426] Starting dynamic subtest: gt_lrc [430.919981] Dynamic subtest gt_lrc: SUCCESS (9.609s) [430.958080] Starting dynamic subtest: gt_mocs [436.927967] Dynamic subtest gt_mocs: SUCCESS (6.002s) [437.040613] Starting dynamic subtest: gt_pm [444.261169] Dynamic subtest gt_pm: SUCCESS (7.324s) [444.300287] Starting dynamic subtest: gt_heartbeat [450.337535] Dynamic subtest gt_heartbeat: SUCCESS (6.069s) [450.370861] Starting dynamic subtest: gt_tlb [456.998853] Dynamic subtest gt_tlb: SUCCESS (6.656s) [457.039377] Starting dynamic subtest: requests [469.613472] Dynamic subtest requests: SUCCESS (12.607s) [469.647560] Starting dynamic subtest: migrate [480.089979] Dynamic subtest migrate: SUCCESS (10.473s) [480.125444] Starting dynamic subtest: active [486.145199] Dynamic subtest active: SUCCESS (6.051s) [486.183297] Starting dynamic subtest: objects [493.618101] Dynamic subtest objects: SUCCESS (7.463s) [493.658510] Starting dynamic subtest: mman [507.263155] Dynamic subtest mman: SUCCESS (13.637s) [507.304275] Starting dynamic subtest: dmabuf [513.583585] Dynamic subtest dmabuf: SUCCESS (6.313s) [513.620713] Starting dynamic subtest: vma [519.619725] Dynamic subtest vma: SUCCESS (6.025s) [519.652992] Starting dynamic subtest: coherency [531.394612] Dynamic subtest coherency: SUCCESS (11.772s) [531.433749] Starting dynamic subtest: gtt [545.471899] Dynamic subtest gtt: SUCCESS (14.067s) [545.507670] Starting dynamic subtest: gem [552.824152] Dynamic subtest gem: SUCCESS (7.342s) [552.865428] Starting dynamic subtest: evict [567.501718] Dynamic subtest evict: SUCCESS (14.674s) [567.542994] Starting dynamic subtest: hugepages [574.144571] Dynamic subtest hugepages: SUCCESS (6.634s) [574.183656] Starting dynamic subtest: gem_contexts [608.350940] Dynamic subtest gem_contexts: SUCCESS (34.199s) [608.394952] Starting dynamic subtest: client [614.108328] Dynamic subtest client: SUCCESS (5.747s) [614.212800] Starting dynamic subtest: gem_migrate [620.220184] Dynamic subtest gem_migrate: SUCCESS (6.103s) [620.258794] Starting dynamic subtest: reset [634.676038] Dynamic subtest reset: SUCCESS (14.448s) [634.717750] Starting dynamic subtest: memory_region [640.698063] Dynamic subtest memory_region: SUCCESS (6.014s) [640.737382] Starting dynamic subtest: hangcheck [670.664337] Dynamic subtest hangcheck: SUCCESS (29.956s) [670.725236] Starting dynamic subtest: execlists [683.124317] Dynamic subtest execlists: SUCCESS (12.451s) [683.165762] Starting dynamic subtest: ring_submission [688.802274] Dynamic subtest ring_submission: SUCCESS (5.663s) [688.844983] Starting dynamic subtest: perf [695.550377] Dynamic subtest perf: SUCCESS (6.735s) [695.605134] Starting dynamic subtest: slpc [701.530117] Dynamic subtest slpc: SUCCESS (5.969s) [701.654372] Starting dynamic subtest: guc [707.943510] Dynamic subtest guc: SUCCESS (6.389s) [708.107209] Starting dynamic subtest: guc_multi_lrc [714.120147] Dynamic subtest guc_multi_lrc: SUCCESS (6.167s) [714.164930] Starting dynamic subtest: guc_hang [720.257666] Dynamic subtest guc_hang: SUCCESS (6.127s) [720.297324] Starting dynamic subtest: late_gt_pm [726.580267] Dynamic subtest late_gt_pm: SUCCESS (6.314s) [726.587485] Subtest live: SUCCESS (374.358s) [726.754416] [162/162] (345s left) dmabuf (all-tests) [727.012536] Starting subtest: all-tests [727.015615] Starting dynamic subtest: sanitycheck [727.062927] Dynamic subtest sanitycheck: SUCCESS (0.058s) [727.191283] Starting dynamic subtest: dma_fence [727.284186] Dynamic subtest dma_fence: SUCCESS (0.206s) [727.363662] Starting dynamic subtest: dma_fence_chain [727.367045] Dynamic subtest dma_fence_chain: SKIP (0.002s) [727.401762] Starting dynamic subtest: dma_fence_unwrap [727.403898] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [727.468421] Starting dynamic subtest: dma_resv [727.477735] Dynamic subtest dma_resv: SUCCESS (0.085s) [727.490617] Subtest all-tests: SUCCESS (0.483s) [727.643568] 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.