[44.779784] Initializing watchdogs [44.779847] /dev/watchdog0 [44.786049] [001/170] (960s left) i915_module_load (load) [44.841181] Starting subtest: load [45.710767] Subtest load: SUCCESS (0.869s) [45.726409] [002/170] (959s left) core_auth (basic-auth) [45.811922] Starting subtest: basic-auth [45.813338] Subtest basic-auth: SUCCESS (0.000s) [45.873824] [003/170] (959s left) debugfs_test (read_all_entries) [45.933215] Starting subtest: read_all_entries [45.979399] Subtest read_all_entries: SUCCESS (0.044s) [46.088293] [004/170] (959s left) debugfs_test (basic-hwmon) [46.143030] Starting subtest: basic-hwmon [46.145503] Subtest basic-hwmon: SKIP (0.000s) [46.238675] [005/170] (959s left) fbdev (eof) [46.311231] Starting subtest: eof [46.313122] Subtest eof: SUCCESS (0.000s) [46.386592] [006/170] (958s left) fbdev (info) [46.450953] Starting subtest: info [46.453039] Subtest info: SUCCESS (0.000s) [46.527146] [007/170] (958s left) fbdev (nullptr) [46.627662] Starting subtest: nullptr [46.629215] Subtest nullptr: SUCCESS (0.000s) [46.670884] [008/170] (958s left) fbdev (read) [46.727456] Starting subtest: read [46.945553] Subtest read: SUCCESS (0.218s) [46.987751] [009/170] (958s left) fbdev (write) [47.060871] Starting subtest: write [47.177255] Subtest write: SUCCESS (0.116s) [47.222158] [010/170] (958s left) gem_basic (bad-close) [47.271910] Starting subtest: bad-close [47.274762] Subtest bad-close: SUCCESS (0.000s) [47.321880] [011/170] (958s left) gem_basic (create-close) [47.373880] Starting subtest: create-close [47.376617] Subtest create-close: SUCCESS (0.000s) [47.443769] [012/170] (958s left) gem_basic (create-fd-close) [47.535862] Starting subtest: create-fd-close [47.538503] Subtest create-fd-close: SUCCESS (0.000s) [47.612718] [013/170] (957s left) gem_busy (busy@all-engines) [47.692234] Starting subtest: busy [47.693544] Starting dynamic subtest: all-engines [47.714306] Dynamic subtest all-engines: SUCCESS (0.022s) [47.715821] Subtest busy: SUCCESS (0.022s) [48.049564] [014/170] (957s left) gem_close_race (basic-process) [48.111429] Starting subtest: basic-process [48.163784] Subtest basic-process: SUCCESS (0.052s) [48.371130] [015/170] (957s left) gem_close_race (basic-threads) [48.475818] Starting subtest: basic-threads [49.679924] Subtest basic-threads: SUCCESS (1.204s) [49.891291] [016/170] (955s left) gem_ctx_create (basic) [49.995055] Starting subtest: basic [49.996633] Subtest basic: SUCCESS (0.000s) [50.180734] [017/170] (955s left) gem_ctx_create (basic-files) [50.235807] Starting subtest: basic-files [52.246119] Subtest basic-files: SUCCESS (2.010s) [52.472716] [018/170] (953s left) gem_ctx_exec (basic) [52.576659] Starting subtest: basic [52.580226] Subtest basic: SUCCESS (0.004s) [52.703977] [019/170] (952s left) gem_exec_basic (basic) [52.765395] Starting subtest: basic [52.766827] Starting dynamic subtest: rcs0-smem [52.768617] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.773597] Starting dynamic subtest: bcs0-smem [52.775146] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [52.780057] Starting dynamic subtest: vcs0-smem [52.781575] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.786202] Starting dynamic subtest: vecs0-smem [52.787906] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.789446] Subtest basic: SUCCESS (0.002s) [53.014295] [020/170] (952s left) gem_exec_create (basic) [53.116490] Starting subtest: basic [53.117883] Starting dynamic subtest: smem [55.163775] Dynamic subtest smem: SUCCESS (2.047s) [55.165228] Subtest basic: SUCCESS (2.047s) [55.322364] [021/170] (950s left) gem_exec_fence (basic-busy) [55.495728] Starting subtest: basic-busy [55.497129] Starting dynamic subtest: rcs0 [55.524611] Dynamic subtest rcs0: SUCCESS (0.029s) [55.532506] Starting dynamic subtest: bcs0 [55.558448] Dynamic subtest bcs0: SUCCESS (0.033s) [55.574577] Starting dynamic subtest: vcs0 [55.595455] Dynamic subtest vcs0: SUCCESS (0.037s) [55.611523] Starting dynamic subtest: vecs0 [55.635377] Dynamic subtest vecs0: SUCCESS (0.040s) [55.637574] Subtest basic-busy: SUCCESS (0.139s) [56.202144] [022/170] (949s left) gem_exec_fence (basic-wait) [56.372483] Starting subtest: basic-wait [56.373920] Starting dynamic subtest: rcs0 [56.399785] Dynamic subtest rcs0: SUCCESS (0.027s) [56.407862] Starting dynamic subtest: bcs0 [56.433638] Dynamic subtest bcs0: SUCCESS (0.033s) [56.455482] Starting dynamic subtest: vcs0 [56.483824] Dynamic subtest vcs0: SUCCESS (0.050s) [56.505501] Starting dynamic subtest: vecs0 [56.524678] Dynamic subtest vecs0: SUCCESS (0.041s) [56.527097] Subtest basic-wait: SUCCESS (0.151s) [57.074119] [023/170] (948s left) gem_exec_fence (basic-await) [57.279587] Starting subtest: basic-await [57.282139] Starting dynamic subtest: rcs0 [57.368655] Dynamic subtest rcs0: SUCCESS (0.090s) [57.376388] Starting dynamic subtest: bcs0 [57.446994] Dynamic subtest bcs0: SUCCESS (0.078s) [57.462765] Starting dynamic subtest: vcs0 [57.543823] Dynamic subtest vcs0: SUCCESS (0.096s) [57.554243] Starting dynamic subtest: vecs0 [57.625918] Dynamic subtest vecs0: SUCCESS (0.082s) [57.627518] Subtest basic-await: SUCCESS (0.347s) [58.183257] [024/170] (947s left) gem_exec_fence (nb-await) [58.383546] Starting subtest: nb-await [58.386182] Starting dynamic subtest: rcs0 [58.456649] Dynamic subtest rcs0: SUCCESS (0.073s) [58.479151] Starting dynamic subtest: bcs0 [58.529635] Dynamic subtest bcs0: SUCCESS (0.073s) [58.550959] Starting dynamic subtest: vcs0 [58.600262] Dynamic subtest vcs0: SUCCESS (0.070s) [58.622390] Starting dynamic subtest: vecs0 [58.669909] Dynamic subtest vecs0: SUCCESS (0.069s) [58.672567] Subtest nb-await: SUCCESS (0.286s) [59.166339] [025/170] (946s left) gem_exec_gttfill (basic) [59.224700] Starting subtest: basic [63.965797] Subtest basic: SUCCESS (4.741s) [64.122602] [026/170] (941s left) gem_exec_parallel (engines) [64.227099] Starting subtest: engines [64.228745] Starting dynamic subtest: basic [65.653839] Dynamic subtest basic: SUCCESS (1.427s) [65.659795] Starting dynamic subtest: contexts [68.236460] Dynamic subtest contexts: SUCCESS (2.583s) [68.242270] Starting dynamic subtest: fds [70.427100] Dynamic subtest fds: SUCCESS (2.190s) [70.433048] Starting dynamic subtest: userptr [72.063208] Dynamic subtest userptr: SUCCESS (1.636s) [72.064912] Subtest engines: SUCCESS (7.836s) [72.271901] [027/170] (933s left) gem_exec_store (basic) [72.361054] Starting subtest: basic [72.412443] Subtest basic: SUCCESS (0.051s) [72.617337] [028/170] (933s left) gem_flink_basic (bad-flink) [72.668604] Starting subtest: bad-flink [72.670052] Subtest bad-flink: SUCCESS (0.000s) [72.726849] [029/170] (933s left) gem_flink_basic (bad-open) [72.786815] Starting subtest: bad-open [72.788695] Subtest bad-open: SUCCESS (0.000s) [72.884575] [030/170] (933s left) gem_flink_basic (basic) [72.949607] Starting subtest: basic [72.951142] Subtest basic: SUCCESS (0.000s) [73.035076] [031/170] (932s left) gem_flink_basic (double-flink) [73.121361] Starting subtest: double-flink [73.122925] Subtest double-flink: SUCCESS (0.000s) [73.194736] [032/170] (932s left) gem_flink_basic (flink-lifetime) [73.250632] Starting subtest: flink-lifetime [73.252072] Subtest flink-lifetime: SUCCESS (0.001s) [73.342529] [033/170] (932s left) gem_huc_copy (huc-copy) [73.396721] Starting subtest: huc-copy [73.399797] Subtest huc-copy: SKIP (0.000s) [73.533744] [034/170] (932s left) gem_linear_blits (basic) [73.695476] Starting subtest: basic [73.699484] Subtest basic: SUCCESS (0.004s) [73.842162] [035/170] (932s left) gem_mmap (basic) [73.982725] Starting subtest: basic [73.990813] Subtest basic: SUCCESS (0.000s) [74.065591] [036/170] (932s left) gem_mmap_gtt (basic) [74.157531] Starting subtest: basic [74.159394] Subtest basic: SUCCESS (0.001s) [74.218089] [037/170] (931s left) gem_render_linear_blits (basic) [74.273645] Starting subtest: basic [74.291355] Subtest basic: SUCCESS (0.018s) [74.357209] [038/170] (931s left) gem_render_tiled_blits (basic) [74.439596] Starting subtest: basic [74.476927] Subtest basic: SUCCESS (0.037s) [74.520854] [039/170] (931s left) gem_ringfill (basic-all) [74.774456] Starting subtest: basic-all [75.928871] Subtest basic-all: SUCCESS (1.157s) [76.026905] [040/170] (930s left) gem_softpin (allocator-basic) [76.087450] Starting subtest: allocator-basic [76.150073] Subtest allocator-basic: SUCCESS (0.063s) [76.255366] [041/170] (929s left) gem_softpin (allocator-basic-reserve) [76.346956] Starting subtest: allocator-basic-reserve [76.407944] Subtest allocator-basic-reserve: SUCCESS (0.061s) [76.501360] [042/170] (929s left) gem_softpin (safe-alignment) [76.564780] Starting subtest: safe-alignment [76.571952] Subtest safe-alignment: SUCCESS (0.007s) [76.675491] [043/170] (929s left) gem_sync (basic-all) [76.750890] Starting subtest: basic-all [78.820597] Subtest basic-all: SUCCESS (2.076s) [79.009234] [044/170] (927s left) gem_sync (basic-each) [79.084684] Starting subtest: basic-each [81.146771] Subtest basic-each: SUCCESS (2.068s) [81.352259] [045/170] (924s left) gem_tiled_blits (basic) [81.501509] Starting subtest: basic [81.513243] Subtest basic: SUCCESS (0.012s) [81.652807] [046/170] (924s left) gem_tiled_fence_blits (basic) [81.890043] Starting subtest: basic [81.896848] Subtest basic: SUCCESS (0.007s) [82.034783] [047/170] (924s left) gem_tiled_pread_basic [82.311345] [048/170] (924s left) gem_wait (busy@all-engines) [82.372212] Starting subtest: busy [82.373812] Starting dynamic subtest: all-engines [82.886736] Dynamic subtest all-engines: SUCCESS (0.515s) [82.888211] Subtest busy: SUCCESS (0.515s) [83.070147] [049/170] (923s left) gem_wait (wait@all-engines) [83.128568] Starting subtest: wait [83.130183] Starting dynamic subtest: all-engines [84.161960] Dynamic subtest all-engines: SUCCESS (1.032s) [84.164594] Subtest wait: SUCCESS (1.033s) [84.360759] [050/170] (922s left) i915_getparams_basic (basic-eu-total) [84.412351] Starting subtest: basic-eu-total [84.415593] Subtest basic-eu-total: SUCCESS (0.000s) [84.517427] [051/170] (921s left) i915_getparams_basic (basic-subslice-total) [84.578207] Starting subtest: basic-subslice-total [84.581618] Subtest basic-subslice-total: SUCCESS (0.000s) [84.643014] [052/170] (921s left) i915_hangman (error-state-basic) [84.723893] Starting subtest: error-state-basic [84.730071] Subtest error-state-basic: SUCCESS (0.004s) [84.816750] [053/170] (921s left) i915_pciid [84.944935] [054/170] (921s left) kms_addfb_basic (addfb25-bad-modifier) [85.005898] Starting subtest: addfb25-bad-modifier [85.007541] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [85.140077] [055/170] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [85.192594] Starting subtest: addfb25-framebuffer-vs-set-tiling [85.194148] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.306357] [056/170] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.359401] Starting subtest: addfb25-modifier-no-flag [85.360950] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.473565] [057/170] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy) [85.526445] Starting subtest: addfb25-x-tiled-legacy [85.527954] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [85.639346] [058/170] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [85.692050] Starting subtest: addfb25-x-tiled-mismatch-legacy [85.693499] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [85.806713] [059/170] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [85.910233] Starting subtest: addfb25-yf-tiled-legacy [85.911787] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [85.973251] [060/170] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [86.076379] Starting subtest: addfb25-y-tiled-legacy [86.077900] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [86.139577] [061/170] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [86.250640] Starting subtest: addfb25-y-tiled-small-legacy [86.252265] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [86.305597] [062/170] (920s left) kms_addfb_basic (bad-pitch-0) [86.356574] Starting subtest: bad-pitch-0 [86.358010] Subtest bad-pitch-0: SUCCESS (0.000s) [86.473253] [063/170] (920s left) kms_addfb_basic (bad-pitch-1024) [86.524626] Starting subtest: bad-pitch-1024 [86.526210] Subtest bad-pitch-1024: SUCCESS (0.000s) [86.656335] [064/170] (919s left) kms_addfb_basic (bad-pitch-128) [86.707896] Starting subtest: bad-pitch-128 [86.709582] Subtest bad-pitch-128: SUCCESS (0.000s) [86.840007] [065/170] (919s left) kms_addfb_basic (bad-pitch-256) [86.898158] Starting subtest: bad-pitch-256 [86.899725] Subtest bad-pitch-256: SUCCESS (0.000s) [87.006334] [066/170] (919s left) kms_addfb_basic (bad-pitch-32) [87.057691] Starting subtest: bad-pitch-32 [87.059212] Subtest bad-pitch-32: SUCCESS (0.000s) [87.172337] [067/170] (919s left) kms_addfb_basic (bad-pitch-63) [87.222154] Starting subtest: bad-pitch-63 [87.223549] Subtest bad-pitch-63: SUCCESS (0.000s) [87.339201] [068/170] (919s left) kms_addfb_basic (bad-pitch-65536) [87.389822] Starting subtest: bad-pitch-65536 [87.391259] Subtest bad-pitch-65536: SUCCESS (0.000s) [87.522822] [069/170] (919s left) kms_addfb_basic (bad-pitch-999) [87.580185] Starting subtest: bad-pitch-999 [87.581710] Subtest bad-pitch-999: SUCCESS (0.000s) [87.689264] [070/170] (919s left) kms_addfb_basic (basic) [87.739788] Starting subtest: basic [87.741118] Subtest basic: SUCCESS (0.000s) [87.872409] [071/170] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [87.928157] Starting subtest: basic-x-tiled-legacy [87.929497] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [88.039081] [072/170] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [88.091943] Starting subtest: basic-y-tiled-legacy [88.093337] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [88.206079] [073/170] (918s left) kms_addfb_basic (bo-too-small) [88.307187] Starting subtest: bo-too-small [88.308533] Subtest bo-too-small: SUCCESS (0.000s) [88.389165] [074/170] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling) [88.496790] Starting subtest: bo-too-small-due-to-tiling [88.498134] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [88.572801] [075/170] (918s left) kms_addfb_basic (clobberred-modifier) [88.623015] Starting subtest: clobberred-modifier [88.624387] Subtest clobberred-modifier: SUCCESS (0.000s) [88.738969] [076/170] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling) [88.790883] Starting subtest: framebuffer-vs-set-tiling [88.792202] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [88.905934] [077/170] (917s left) kms_addfb_basic (invalid-get-prop) [88.957962] Starting subtest: invalid-get-prop [88.959248] Subtest invalid-get-prop: SUCCESS (0.000s) [89.072379] [078/170] (917s left) kms_addfb_basic (invalid-get-prop-any) [89.125432] Starting subtest: invalid-get-prop-any [89.126858] Subtest invalid-get-prop-any: SUCCESS (0.000s) [89.238989] [079/170] (917s left) kms_addfb_basic (invalid-set-prop) [89.290438] Starting subtest: invalid-set-prop [89.291877] Subtest invalid-set-prop: SUCCESS (0.000s) [89.405863] [080/170] (917s left) kms_addfb_basic (invalid-set-prop-any) [89.457976] Starting subtest: invalid-set-prop-any [89.459273] Subtest invalid-set-prop-any: SUCCESS (0.000s) [89.572871] [081/170] (917s left) kms_addfb_basic (no-handle) [89.625035] Starting subtest: no-handle [89.626499] Subtest no-handle: SUCCESS (0.000s) [89.742966] [082/170] (917s left) kms_addfb_basic (size-max) [89.881333] Starting subtest: size-max [89.882805] Subtest size-max: SUCCESS (0.000s) [89.956230] [083/170] (916s left) kms_addfb_basic (small-bo) [90.056319] Starting subtest: small-bo [90.057789] Subtest small-bo: SUCCESS (0.000s) [90.122700] [084/170] (916s left) kms_addfb_basic (tile-pitch-mismatch) [90.175896] Starting subtest: tile-pitch-mismatch [90.177426] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [90.294047] [085/170] (916s left) kms_addfb_basic (too-high) [90.394207] Starting subtest: too-high [90.395589] Subtest too-high: SUCCESS (0.000s) [90.472345] [086/170] (916s left) kms_addfb_basic (too-wide) [90.575879] Starting subtest: too-wide [90.577346] Subtest too-wide: SUCCESS (0.000s) [90.639159] [087/170] (916s left) kms_addfb_basic (unused-handle) [90.690105] Starting subtest: unused-handle [90.691518] Subtest unused-handle: SUCCESS (0.000s) [90.806118] [088/170] (916s left) kms_addfb_basic (unused-modifier) [90.857086] Starting subtest: unused-modifier [90.858591] Subtest unused-modifier: SUCCESS (0.000s) [90.972369] [089/170] (915s left) kms_addfb_basic (unused-offsets) [91.023643] Starting subtest: unused-offsets [91.024935] Subtest unused-offsets: SUCCESS (0.000s) [91.156126] [090/170] (915s left) kms_addfb_basic (unused-pitches) [91.206131] Starting subtest: unused-pitches [91.207421] Subtest unused-pitches: SUCCESS (0.000s) [91.339642] [091/170] (915s left) kms_busy (basic) [91.452504] Starting subtest: basic [91.453880] Starting dynamic subtest: flip [91.915041] Dynamic subtest flip: SUCCESS (0.462s) [91.922670] Starting dynamic subtest: modeset [92.263170] Dynamic subtest modeset: SUCCESS (0.349s) [92.264656] Subtest basic: SUCCESS (0.811s) [92.374560] [092/170] (914s left) kms_chamelium_hpd (dp-hpd-fast) [92.501152] Subtest dp-hpd-fast: SKIP (0.000s) [92.549127] [093/170] (914s left) kms_chamelium_edid (dp-edid-read) [92.679308] Subtest dp-edid-read: SKIP (0.000s) [92.726976] [094/170] (914s left) kms_chamelium_frames (dp-crc-fast) [92.857674] Subtest dp-crc-fast: SKIP (0.000s) [92.901854] [095/170] (914s left) kms_chamelium_hpd (hdmi-hpd-fast) [93.034971] Subtest hdmi-hpd-fast: SKIP (0.000s) [93.080124] [096/170] (913s left) kms_chamelium_edid (hdmi-edid-read) [93.211995] Subtest hdmi-edid-read: SKIP (0.000s) [93.256876] [097/170] (913s left) kms_chamelium_frames (hdmi-crc-fast) [93.389201] Subtest hdmi-crc-fast: SKIP (0.000s) [93.435247] [098/170] (913s left) kms_chamelium_hpd (vga-hpd-fast) [93.566904] Subtest vga-hpd-fast: SKIP (0.000s) [93.611120] [099/170] (913s left) kms_chamelium_edid (vga-edid-read) [93.742638] Subtest vga-edid-read: SKIP (0.000s) [93.789592] [100/170] (913s left) kms_prop_blob (basic) [93.841342] Starting subtest: basic [93.842725] Subtest basic: SUCCESS (0.000s) [93.891091] [101/170] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [93.993160] Starting subtest: basic-busy-flip-before-cursor-atomic [93.995841] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [94.041618] [102/170] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.143151] Starting subtest: basic-busy-flip-before-cursor-legacy [94.145830] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [94.191731] [103/170] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [94.291492] Starting subtest: basic-flip-after-cursor-atomic [95.201916] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.910s) [95.295959] [104/170] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [95.398147] Starting subtest: basic-flip-after-cursor-legacy [96.305143] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.908s) [96.402516] [105/170] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [96.504191] Starting subtest: basic-flip-after-cursor-varying-size [97.428391] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.923s) [97.529350] [106/170] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [97.630294] Starting subtest: basic-flip-before-cursor-atomic [98.539542] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.908s) [98.637364] [107/170] (908s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [98.739724] Starting subtest: basic-flip-before-cursor-legacy [99.664887] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.925s) [99.765968] [108/170] (907s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [99.868421] Starting subtest: basic-flip-before-cursor-varying-size [100.775212] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.906s) [100.868602] [109/170] (906s left) kms_flip (basic-flip-vs-dpms) [100.959886] Starting subtest: basic-flip-vs-dpms [100.961427] Starting dynamic subtest: A-HDMI-A1 [101.811293] Dynamic subtest A-HDMI-A1: SUCCESS (0.851s) [101.817618] Starting dynamic subtest: B-HDMI-A1 [102.624389] Dynamic subtest B-HDMI-A1: SUCCESS (0.813s) [102.630234] Starting dynamic subtest: C-HDMI-A1 [103.449706] Dynamic subtest C-HDMI-A1: SUCCESS (0.825s) [103.451232] Subtest basic-flip-vs-dpms: SUCCESS (2.493s) [103.584885] [110/170] (903s left) kms_flip (basic-flip-vs-modeset) [103.678505] Starting subtest: basic-flip-vs-modeset [103.679853] Starting dynamic subtest: A-HDMI-A1 [104.506654] Dynamic subtest A-HDMI-A1: SUCCESS (0.827s) [104.512939] Starting dynamic subtest: B-HDMI-A1 [105.293920] Dynamic subtest B-HDMI-A1: SUCCESS (0.786s) [105.300066] Starting dynamic subtest: C-HDMI-A1 [106.086710] Dynamic subtest C-HDMI-A1: SUCCESS (0.793s) [106.088186] Subtest basic-flip-vs-modeset: SUCCESS (2.410s) [106.176096] [111/170] (901s left) kms_flip (basic-flip-vs-wf_vblank) [106.269466] Starting subtest: basic-flip-vs-wf_vblank [106.270930] Starting dynamic subtest: A-HDMI-A1 [107.368912] Dynamic subtest A-HDMI-A1: SUCCESS (1.098s) [107.375112] Starting dynamic subtest: B-HDMI-A1 [108.459040] Dynamic subtest B-HDMI-A1: SUCCESS (1.089s) [108.465207] Starting dynamic subtest: C-HDMI-A1 [109.532513] Dynamic subtest C-HDMI-A1: SUCCESS (1.073s) [109.533774] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.265s) [109.649766] [112/170] (897s left) kms_flip (basic-plain-flip) [109.742323] Starting subtest: basic-plain-flip [109.744145] Starting dynamic subtest: A-HDMI-A1 [110.563112] Dynamic subtest A-HDMI-A1: SUCCESS (0.822s) [110.569248] Starting dynamic subtest: B-HDMI-A1 [111.353460] Dynamic subtest B-HDMI-A1: SUCCESS (0.789s) [111.361961] Starting dynamic subtest: C-HDMI-A1 [112.159288] Dynamic subtest C-HDMI-A1: SUCCESS (0.805s) [112.160819] Subtest basic-plain-flip: SUCCESS (2.421s) [112.276826] [113/170] (894s left) kms_force_connector_basic (force-connector-state) [112.429495] Starting subtest: force-connector-state [112.774866] Subtest force-connector-state: SUCCESS (0.345s) [113.182703] [114/170] (894s left) kms_force_connector_basic (force-edid) [113.333375] Starting subtest: force-edid [113.470601] Subtest force-edid: SUCCESS (0.137s) [113.665921] [115/170] (893s left) kms_force_connector_basic (force-load-detect) [113.817149] Starting subtest: force-load-detect [113.819796] Subtest force-load-detect: SKIP (0.000s) [114.015943] [116/170] (893s left) kms_force_connector_basic (prune-stale-modes) [114.167229] Starting subtest: prune-stale-modes [114.301216] Subtest prune-stale-modes: SUCCESS (0.134s) [114.499226] [117/170] (892s left) kms_frontbuffer_tracking (basic) [114.609121] Starting subtest: basic [116.986763] Subtest basic: SUCCESS (2.383s) [117.071889] [118/170] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [117.175089] Starting subtest: compare-crc-sanitycheck [117.176438] Starting dynamic subtest: pipe-A-HDMI-A-1 [117.529131] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.351s) [117.536597] Starting dynamic subtest: pipe-B-HDMI-A-1 [117.884628] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.353s) [117.892067] Starting dynamic subtest: pipe-C-HDMI-A-1 [118.241776] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.356s) [118.243184] Subtest compare-crc-sanitycheck: SUCCESS (1.066s) [118.331186] [119/170] (889s left) kms_pipe_crc_basic (hang-read-crc) [118.435386] Starting subtest: hang-read-crc [118.436779] Starting dynamic subtest: pipe-A-HDMI-A-1 [119.245322] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.808s) [119.252499] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.080819] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.835s) [120.087393] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.983852] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.901s) [120.985197] Subtest hang-read-crc: SUCCESS (2.548s) [121.062647] [120/170] (886s left) kms_pipe_crc_basic (nonblocking-crc) [121.167183] Starting subtest: nonblocking-crc [121.168738] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.654924] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.487s) [121.662653] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.139957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.481s) [122.149384] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.663403] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.523s) [122.664746] Subtest nonblocking-crc: SUCCESS (1.496s) [122.744694] [121/170] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.850350] Starting subtest: nonblocking-crc-frame-sequence [122.851923] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.353598] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.501s) [123.361456] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.833388] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.478s) [123.840218] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.351799] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.517s) [124.353387] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.501s) [124.429872] [122/170] (882s left) kms_pipe_crc_basic (read-crc) [124.534500] Starting subtest: read-crc [124.536104] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.956940] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.420s) [124.964363] Starting dynamic subtest: pipe-B-HDMI-A-1 [125.370118] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.412s) [125.376880] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.819493] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.449s) [125.821108] Subtest read-crc: SUCCESS (1.286s) [125.898738] [123/170] (881s left) kms_pipe_crc_basic (read-crc-frame-sequence) [126.002954] Starting subtest: read-crc-frame-sequence [126.004407] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.442203] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.439s) [126.451923] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.858436] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.412s) [126.865220] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.311881] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.452s) [127.313392] Subtest read-crc-frame-sequence: SUCCESS (1.309s) [127.390238] [124/170] (880s left) kms_psr (primary_page_flip) [127.444189] Subtest primary_page_flip: SKIP (0.000s) [127.468191] [125/170] (879s left) kms_psr (cursor_plane_move) [127.519834] Subtest cursor_plane_move: SKIP (0.000s) [127.534710] [126/170] (879s left) kms_psr (sprite_plane_onoff) [127.587246] Subtest sprite_plane_onoff: SKIP (0.000s) [127.601751] [127/170] (879s left) kms_psr (primary_mmap_gtt) [127.657185] Subtest primary_mmap_gtt: SKIP (0.000s) [127.685267] [128/170] (879s left) kms_setmode (basic-clone-single-crtc) [127.747806] Starting subtest: basic-clone-single-crtc [127.753238] Subtest basic-clone-single-crtc: SKIP (0.000s) [127.809924] [129/170] (879s left) i915_pm_backlight (basic-brightness) [127.916584] Subtest basic-brightness: SKIP (0.000s) [127.934774] [130/170] (879s left) i915_pm_rpm (basic-pci-d3-state) [129.338389] Starting subtest: basic-pci-d3-state [129.687578] Subtest basic-pci-d3-state: SUCCESS (0.348s) [129.968699] [131/170] (877s left) i915_pm_rpm (basic-rte) [130.021318] Starting subtest: basic-rte [131.746499] Subtest basic-rte: SUCCESS (1.725s) [132.338731] [132/170] (875s left) i915_pm_rps (basic-api) [132.393589] Starting subtest: basic-api [132.396826] Subtest basic-api: SUCCESS (0.002s) [132.466201] [133/170] (875s left) prime_self_import (basic-llseek-bad) [132.520157] Starting subtest: basic-llseek-bad [132.521504] Subtest basic-llseek-bad: SUCCESS (0.001s) [132.594916] [134/170] (874s left) prime_self_import (basic-llseek-size) [132.671962] Starting subtest: basic-llseek-size [132.673462] Subtest basic-llseek-size: SUCCESS (0.002s) [132.793326] [135/170] (874s left) prime_self_import (basic-with_fd_dup) [132.882213] Starting subtest: basic-with_fd_dup [132.883628] Subtest basic-with_fd_dup: SUCCESS (0.002s) [132.988058] [136/170] (874s left) prime_self_import (basic-with_one_bo) [133.046493] Starting subtest: basic-with_one_bo [133.049793] Subtest basic-with_one_bo: SUCCESS (0.002s) [133.100377] [137/170] (874s left) prime_self_import (basic-with_one_bo_two_files) [133.151641] Starting subtest: basic-with_one_bo_two_files [133.152982] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [133.231281] [138/170] (874s left) prime_self_import (basic-with_two_bos) [133.289519] Starting subtest: basic-with_two_bos [133.290886] Subtest basic-with_two_bos: SUCCESS (0.001s) [133.389955] [139/170] (874s left) prime_vgem (basic-fence-flip) [133.507496] Starting subtest: basic-fence-flip [133.910399] Subtest basic-fence-flip: SUCCESS (0.402s) [133.990210] [140/170] (873s left) prime_vgem (basic-fence-mmap) [134.067806] Starting subtest: basic-fence-mmap [134.090195] Subtest basic-fence-mmap: SUCCESS (0.022s) [134.220997] [141/170] (873s left) prime_vgem (basic-fence-read) [134.320767] Starting subtest: basic-fence-read [134.345662] Subtest basic-fence-read: SUCCESS (0.025s) [134.464262] [142/170] (873s left) prime_vgem (basic-gtt) [134.528702] Starting subtest: basic-gtt [134.536046] Subtest basic-gtt: SUCCESS (0.007s) [134.633406] [143/170] (873s left) prime_vgem (basic-read) [134.729164] Starting subtest: basic-read [134.740428] Subtest basic-read: SUCCESS (0.012s) [134.836509] [144/170] (873s left) prime_vgem (basic-write) [134.917419] Starting subtest: basic-write [134.929761] Subtest basic-write: SUCCESS (0.012s) [135.036811] [145/170] (872s left) vgem_basic (setversion) [135.109062] Starting subtest: setversion [135.112053] Subtest setversion: SUCCESS (0.000s) [135.157246] [146/170] (872s left) vgem_basic (create) [135.225716] Starting subtest: create [135.227443] Subtest create: SUCCESS (0.000s) [135.275467] [147/170] (872s left) vgem_basic (debugfs) [135.358930] Starting subtest: debugfs [135.360559] Subtest debugfs: SUCCESS (0.000s) [135.410050] [148/170] (872s left) vgem_basic (dmabuf-export) [135.492411] Starting subtest: dmabuf-export [135.493780] Subtest dmabuf-export: SUCCESS (0.001s) [135.589982] [149/170] (872s left) vgem_basic (dmabuf-fence) [135.692456] Starting subtest: dmabuf-fence [135.694073] Subtest dmabuf-fence: SUCCESS (0.000s) [135.746555] [150/170] (872s left) vgem_basic (dmabuf-fence-before) [135.842503] Starting subtest: dmabuf-fence-before [135.844118] Subtest dmabuf-fence-before: SUCCESS (0.000s) [135.891411] [151/170] (872s left) vgem_basic (dmabuf-mmap) [135.976200] Starting subtest: dmabuf-mmap [135.984368] Subtest dmabuf-mmap: SUCCESS (0.009s) [136.022061] [152/170] (872s left) vgem_basic (mmap) [136.092420] Starting subtest: mmap [136.098196] Subtest mmap: SUCCESS (0.006s) [136.138611] [153/170] (871s left) vgem_basic (second-client) [136.192764] Starting subtest: second-client [136.242235] Subtest second-client: SUCCESS (0.049s) [136.336099] [154/170] (871s left) vgem_basic (sysfs) [136.425775] Starting subtest: sysfs [136.427232] Subtest sysfs: SUCCESS (0.000s) [136.475113] [155/170] (871s left) core_hotunplug (unbind-rebind) [136.575986] Starting subtest: unbind-rebind [137.462636] Subtest unbind-rebind: SUCCESS (0.887s) [137.476363] [156/170] (870s left) vgem_basic (unload) [137.531319] Starting subtest: unload [166.417768] Subtest unload: SUCCESS (28.886s) [166.514199] [157/170] (841s left) i915_module_load (reload) [166.566333] Starting subtest: reload [168.388618] Subtest reload: SUCCESS (1.823s) [168.407160] [158/170] (839s left) gem_lmem_swapping (basic) [168.483819] Subtest basic: SKIP (0.000s) [168.512247] [159/170] (839s left) gem_lmem_swapping (parallel-random-engines) [168.567126] Subtest parallel-random-engines: SKIP (0.000s) [168.596417] [160/170] (839s left) gem_lmem_swapping (random-engines) [168.652333] Subtest random-engines: SKIP (0.000s) [168.679559] [161/170] (839s left) gem_lmem_swapping (verify-random) [168.741019] Subtest verify-random: SKIP (0.000s) [168.763497] [162/170] (839s left) i915_pm_rpm (module-reload) [170.438570] Starting subtest: module-reload [178.238643] Subtest module-reload: SUCCESS (7.799s) [178.274768] [163/170] (829s left) i915_selftest (live) [178.342948] Starting subtest: live [178.344612] Starting dynamic subtest: sanitycheck [178.867154] Dynamic subtest sanitycheck: SUCCESS (0.524s) [178.872904] Starting dynamic subtest: uncore [179.353141] Dynamic subtest uncore: SUCCESS (0.486s) [179.358808] Starting dynamic subtest: workarounds [180.015084] Dynamic subtest workarounds: SUCCESS (0.662s) [180.020477] Starting dynamic subtest: gt_engines [180.961294] Dynamic subtest gt_engines: SUCCESS (0.946s) [180.966883] Starting dynamic subtest: gt_timelines [186.657248] Dynamic subtest gt_timelines: SUCCESS (5.696s) [186.663474] Starting dynamic subtest: gt_contexts [187.244083] Dynamic subtest gt_contexts: SUCCESS (0.587s) [187.250661] Starting dynamic subtest: gt_lrc [190.012179] Dynamic subtest gt_lrc: SUCCESS (2.768s) [190.017991] Starting dynamic subtest: gt_mocs [190.582066] Dynamic subtest gt_mocs: SUCCESS (0.570s) [190.588485] Starting dynamic subtest: gt_pm [192.975040] Dynamic subtest gt_pm: SUCCESS (2.393s) [192.980517] Starting dynamic subtest: gt_heartbeat [193.551261] Dynamic subtest gt_heartbeat: SUCCESS (0.576s) [193.556907] Starting dynamic subtest: gt_tlb [194.877016] Dynamic subtest gt_tlb: SUCCESS (1.326s) [194.882030] Starting dynamic subtest: requests [201.575089] Dynamic subtest requests: SUCCESS (6.698s) [201.580385] Starting dynamic subtest: migrate [204.961825] Dynamic subtest migrate: SUCCESS (3.387s) [204.967926] Starting dynamic subtest: active [205.423955] Dynamic subtest active: SUCCESS (0.462s) [205.429748] Starting dynamic subtest: objects [206.481978] Dynamic subtest objects: SUCCESS (1.058s) [206.487636] Starting dynamic subtest: mman [210.276058] Dynamic subtest mman: SUCCESS (3.794s) [210.281679] Starting dynamic subtest: dmabuf [210.782169] Dynamic subtest dmabuf: SUCCESS (0.506s) [210.788016] Starting dynamic subtest: vma [211.284196] Dynamic subtest vma: SUCCESS (0.502s) [211.290190] Starting dynamic subtest: coherency [212.298114] Dynamic subtest coherency: SUCCESS (1.014s) [212.303601] Starting dynamic subtest: gtt [220.346180] Dynamic subtest gtt: SUCCESS (8.048s) [220.351761] Starting dynamic subtest: gem [220.900058] Dynamic subtest gem: SUCCESS (0.554s) [220.905730] Starting dynamic subtest: evict [222.124178] Dynamic subtest evict: SUCCESS (1.224s) [222.129725] Starting dynamic subtest: hugepages [227.710094] Dynamic subtest hugepages: SUCCESS (5.586s) [227.715642] Starting dynamic subtest: gem_contexts [239.705232] Dynamic subtest gem_contexts: SUCCESS (11.995s) [239.711022] Starting dynamic subtest: client [240.249439] Dynamic subtest client: SUCCESS (0.544s) [240.255294] Starting dynamic subtest: gem_migrate [240.725106] Dynamic subtest gem_migrate: SUCCESS (0.476s) [240.730430] Starting dynamic subtest: reset [241.541236] Dynamic subtest reset: SUCCESS (0.816s) [241.547197] Starting dynamic subtest: memory_region [242.009119] Dynamic subtest memory_region: SUCCESS (0.468s) [242.015262] Starting dynamic subtest: hangcheck [265.473153] Dynamic subtest hangcheck: SUCCESS (23.464s) [265.478801] Starting dynamic subtest: execlists [273.694182] Dynamic subtest execlists: SUCCESS (8.221s) [273.700247] Starting dynamic subtest: ring_submission [274.178153] Dynamic subtest ring_submission: SUCCESS (0.484s) [274.183491] Starting dynamic subtest: perf [274.783238] Dynamic subtest perf: SUCCESS (0.605s) [274.788742] Starting dynamic subtest: slpc [275.277164] Dynamic subtest slpc: SUCCESS (0.494s) [275.282489] Starting dynamic subtest: guc [275.773538] Dynamic subtest guc: SUCCESS (0.496s) [275.781246] Starting dynamic subtest: guc_multi_lrc [276.252163] Dynamic subtest guc_multi_lrc: SUCCESS (0.479s) [276.257565] Starting dynamic subtest: guc_hang [276.695128] Dynamic subtest guc_hang: SUCCESS (0.443s) [276.700506] Starting dynamic subtest: late_gt_pm [277.219129] Dynamic subtest late_gt_pm: SUCCESS (0.524s) [277.220669] Subtest live: SUCCESS (98.876s) [277.440186] [164/170] (730s left) dmabuf (all-tests) [277.503231] Starting subtest: all-tests [277.505460] Starting dynamic subtest: sanitycheck [277.567036] Dynamic subtest sanitycheck: SUCCESS (0.064s) [277.576091] Starting dynamic subtest: dma_fence [277.739859] Dynamic subtest dma_fence: SUCCESS (0.172s) [277.748927] Starting dynamic subtest: dma_fence_chain [287.938915] Dynamic subtest dma_fence_chain: SUCCESS (10.198s) [287.946855] Starting dynamic subtest: dma_fence_unwrap [288.003444] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [288.019808] Starting dynamic subtest: dma_resv [288.081111] Dynamic subtest dma_resv: SUCCESS (0.077s) [288.082931] Subtest all-tests: SUCCESS (10.578s) [288.109322] [165/170] (720s left) i915_suspend (basic-s2idle-without-i915) [288.206036] Starting subtest: basic-s2idle-without-i915 [305.569868] Subtest basic-s2idle-without-i915: SUCCESS (2.019s) [311.719653] [166/170] (717s left) i915_suspend (basic-s3-without-i915) [311.775253] Starting subtest: basic-s3-without-i915 [329.633561] Subtest basic-s3-without-i915: SUCCESS (1.955s) [334.991200] [167/170] (715s left) gem_exec_suspend (basic-s0) [335.057683] Starting subtest: basic-S0 [335.059401] Starting dynamic subtest: smem [352.623115] Dynamic subtest smem: SUCCESS (1.649s) [352.624939] Subtest basic-S0: SUCCESS (1.650s) [357.949893] [168/170] (713s left) gem_exec_suspend (basic-s3) [358.011769] Starting subtest: basic-S3 [358.013671] Starting dynamic subtest: smem [375.676790] Dynamic subtest smem: SUCCESS (1.784s) [375.678636] Subtest basic-S3: SUCCESS (1.785s) [381.870795] [169/170] (711s left) kms_chamelium_hpd (common-hpd-after-suspend) [381.995348] Subtest common-hpd-after-suspend: SKIP (0.000s) [382.043053] [170/170] (711s left) kms_pipe_crc_basic (suspend-read-crc) [382.146929] Starting subtest: suspend-read-crc [382.148724] Starting dynamic subtest: pipe-A-HDMI-A-1 [399.677962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.602s) [399.688210] Starting dynamic subtest: pipe-B-HDMI-A-1 [417.753460] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.655s) [417.761835] Starting dynamic subtest: pipe-C-HDMI-A-1 [435.783499] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.710s) [435.785260] Subtest suspend-read-crc: SUCCESS (4.973s) [439.970277] Closing watchdogs Done.