[37.579020] Initializing watchdogs [37.579140] /dev/watchdog0 [37.586072] [001/171] (960s left) i915_module_load (load) [37.688835] Starting subtest: load [38.707920] Subtest load: SUCCESS (1.017s) [38.735489] [002/171] (959s left) core_auth (basic-auth) [38.858178] Starting subtest: basic-auth [38.859272] Subtest basic-auth: SUCCESS (0.001s) [38.950790] [003/171] (959s left) debugfs_test (read_all_entries) [39.113357] Starting subtest: read_all_entries [39.197972] Subtest read_all_entries: SUCCESS (0.084s) [39.303485] [004/171] (958s left) debugfs_test (basic-hwmon) [39.395731] Starting subtest: basic-hwmon [39.397422] Subtest basic-hwmon: SKIP (0.000s) [39.518440] [005/171] (958s left) fbdev (eof) [39.610133] Starting subtest: eof [39.611196] Subtest eof: SUCCESS (0.000s) [39.663702] [006/171] (958s left) fbdev (info) [39.752396] Starting subtest: info [39.753408] Subtest info: SUCCESS (0.000s) [39.811741] [007/171] (958s left) fbdev (nullptr) [39.910094] Starting subtest: nullptr [39.911166] Subtest nullptr: SUCCESS (0.000s) [39.967967] [008/171] (958s left) fbdev (read) [40.060128] Starting subtest: read [40.915102] Subtest read: SUCCESS (0.846s) [40.963394] [009/171] (957s left) fbdev (write) [41.060457] Starting subtest: write [41.481794] Subtest write: SUCCESS (0.413s) [41.518585] [010/171] (956s left) gem_basic (bad-close) [41.606292] Starting subtest: bad-close [41.608123] Subtest bad-close: SUCCESS (0.000s) [41.674904] [011/171] (956s left) gem_basic (create-close) [41.768476] Starting subtest: create-close [41.770356] Subtest create-close: SUCCESS (0.000s) [41.901766] [012/171] (956s left) gem_basic (create-fd-close) [42.004138] Starting subtest: create-fd-close [42.006053] Subtest create-fd-close: SUCCESS (0.000s) [42.133209] [013/171] (956s left) gem_busy (busy@all-engines) [42.251113] Starting subtest: busy [42.252128] Starting dynamic subtest: all-engines [42.311730] Dynamic subtest all-engines: SUCCESS (0.060s) [42.312720] Subtest busy: SUCCESS (0.061s) [42.719790] [014/171] (955s left) gem_close_race (basic-process) [42.826838] Starting subtest: basic-process [42.895151] Subtest basic-process: SUCCESS (0.069s) [43.105240] [015/171] (955s left) gem_close_race (basic-threads) [43.216172] Starting subtest: basic-threads [44.357569] Subtest basic-threads: SUCCESS (1.141s) [44.605533] [016/171] (953s left) gem_ctx_create (basic) [44.720375] Starting subtest: basic [44.721557] Subtest basic: SUCCESS (0.000s) [44.935206] [017/171] (953s left) gem_ctx_create (basic-files) [45.039217] Starting subtest: basic-files [47.065054] Subtest basic-files: SUCCESS (2.017s) [47.375566] [018/171] (951s left) gem_ctx_exec (basic) [47.487465] Starting subtest: basic [47.492430] Subtest basic: SUCCESS (0.005s) [47.573060] [019/171] (950s left) gem_exec_basic (basic) [47.681901] Starting subtest: basic [47.682913] Starting dynamic subtest: rcs0-smem [47.683937] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [47.691188] Starting dynamic subtest: bcs0-smem [47.692201] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [47.699060] Starting dynamic subtest: vcs0-smem [47.700355] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [47.707211] Starting dynamic subtest: vecs0-smem [47.708576] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [47.709948] Subtest basic: SUCCESS (0.007s) [47.903567] [020/171] (950s left) gem_exec_create (basic) [48.009189] Starting subtest: basic [48.010423] Starting dynamic subtest: smem [50.052825] Dynamic subtest smem: SUCCESS (2.043s) [50.054173] Subtest basic: SUCCESS (2.043s) [50.266945] [021/171] (948s left) gem_exec_fence (basic-busy) [50.517231] Starting subtest: basic-busy [50.519483] Starting dynamic subtest: rcs0 [50.543361] Dynamic subtest rcs0: SUCCESS (0.027s) [50.551908] Starting dynamic subtest: bcs0 [50.574308] Dynamic subtest bcs0: SUCCESS (0.031s) [50.581104] Starting dynamic subtest: vcs0 [50.600278] Dynamic subtest vcs0: SUCCESS (0.026s) [50.607351] Starting dynamic subtest: vecs0 [50.623421] Dynamic subtest vecs0: SUCCESS (0.023s) [50.624451] Subtest basic-busy: SUCCESS (0.107s) [51.306179] [022/171] (947s left) gem_exec_fence (basic-wait) [51.559139] Starting subtest: basic-wait [51.560602] Starting dynamic subtest: rcs0 [51.584365] Dynamic subtest rcs0: SUCCESS (0.026s) [51.591909] Starting dynamic subtest: bcs0 [51.610378] Dynamic subtest bcs0: SUCCESS (0.026s) [51.617916] Starting dynamic subtest: vcs0 [51.628389] Dynamic subtest vcs0: SUCCESS (0.018s) [51.636611] Starting dynamic subtest: vecs0 [51.649445] Dynamic subtest vecs0: SUCCESS (0.021s) [51.650345] Subtest basic-wait: SUCCESS (0.091s) [52.300452] [023/171] (946s left) gem_exec_fence (basic-await) [52.550451] Starting subtest: basic-await [52.552300] Starting dynamic subtest: rcs0 [52.641986] Dynamic subtest rcs0: SUCCESS (0.091s) [52.652606] Starting dynamic subtest: bcs0 [52.737413] Dynamic subtest bcs0: SUCCESS (0.095s) [52.748948] Starting dynamic subtest: vcs0 [52.831975] Dynamic subtest vcs0: SUCCESS (0.095s) [52.840724] Starting dynamic subtest: vecs0 [52.922867] Dynamic subtest vecs0: SUCCESS (0.091s) [52.924779] Subtest basic-await: SUCCESS (0.372s) [53.652744] [024/171] (944s left) gem_exec_fence (nb-await) [53.900101] Starting subtest: nb-await [53.901996] Starting dynamic subtest: rcs0 [53.972162] Dynamic subtest rcs0: SUCCESS (0.073s) [53.999543] Starting dynamic subtest: bcs0 [54.059966] Dynamic subtest bcs0: SUCCESS (0.086s) [54.102401] Starting dynamic subtest: vcs0 [54.164729] Dynamic subtest vcs0: SUCCESS (0.104s) [54.210672] Starting dynamic subtest: vecs0 [54.275689] Dynamic subtest vecs0: SUCCESS (0.109s) [54.278805] Subtest nb-await: SUCCESS (0.376s) [55.020302] [025/171] (943s left) gem_exec_gttfill (basic) [55.131052] Starting subtest: basic [64.130052] Subtest basic: SUCCESS (8.991s) [64.314882] [026/171] (934s left) gem_exec_parallel (engines) [64.480214] Starting subtest: engines [64.481691] Starting dynamic subtest: basic [66.797798] Dynamic subtest basic: SUCCESS (2.309s) [66.805416] Starting dynamic subtest: contexts [69.613177] Dynamic subtest contexts: SUCCESS (2.815s) [69.621233] Starting dynamic subtest: fds [73.001446] Dynamic subtest fds: SUCCESS (3.397s) [73.012071] Starting dynamic subtest: userptr [75.357728] Dynamic subtest userptr: SUCCESS (2.355s) [75.360055] Subtest engines: SUCCESS (10.877s) [75.570302] [027/171] (923s left) gem_exec_store (basic) [75.684809] Starting subtest: basic [75.730854] Subtest basic: SUCCESS (0.046s) [75.950078] [028/171] (922s left) gem_flink_basic (bad-flink) [76.047998] Starting subtest: bad-flink [76.049098] Subtest bad-flink: SUCCESS (0.000s) [76.114376] [029/171] (922s left) gem_flink_basic (bad-open) [76.211109] Starting subtest: bad-open [76.212095] Subtest bad-open: SUCCESS (0.000s) [76.281454] [030/171] (922s left) gem_flink_basic (basic) [76.380561] Starting subtest: basic [76.381609] Subtest basic: SUCCESS (0.000s) [76.447893] [031/171] (922s left) gem_flink_basic (double-flink) [76.546440] Starting subtest: double-flink [76.547430] Subtest double-flink: SUCCESS (0.000s) [76.658380] [032/171] (922s left) gem_flink_basic (flink-lifetime) [76.755219] Starting subtest: flink-lifetime [76.756236] Subtest flink-lifetime: SUCCESS (0.001s) [76.858388] [033/171] (921s left) gem_huc_copy (huc-copy) [76.962604] Starting subtest: huc-copy [76.964825] Subtest huc-copy: SKIP (0.000s) [77.087542] [034/171] (921s left) gem_linear_blits (basic) [77.338877] Starting subtest: basic [77.348395] Subtest basic: SUCCESS (0.010s) [77.483792] [035/171] (921s left) gem_mmap (basic) [77.630904] Starting subtest: basic [77.635738] Subtest basic: SUCCESS (0.001s) [77.714677] [036/171] (921s left) gem_mmap_gtt (basic) [77.812237] Starting subtest: basic [77.813671] Subtest basic: SUCCESS (0.001s) [77.869348] [037/171] (920s left) gem_render_linear_blits (basic) [77.972605] Starting subtest: basic [78.013239] Subtest basic: SUCCESS (0.040s) [78.050726] [038/171] (920s left) gem_render_tiled_blits (basic) [78.157787] Starting subtest: basic [78.201795] Subtest basic: SUCCESS (0.044s) [78.251430] [039/171] (920s left) gem_ringfill (basic-all) [78.522369] Starting subtest: basic-all [79.686976] Subtest basic-all: SUCCESS (1.157s) [79.786724] [040/171] (919s left) gem_softpin (allocator-basic) [79.898130] Starting subtest: allocator-basic [80.031930] Subtest allocator-basic: SUCCESS (0.125s) [80.160649] [041/171] (918s left) gem_softpin (allocator-basic-reserve) [80.263660] Starting subtest: allocator-basic-reserve [80.403285] Subtest allocator-basic-reserve: SUCCESS (0.131s) [80.524467] [042/171] (918s left) gem_softpin (safe-alignment) [80.627492] Starting subtest: safe-alignment [80.642641] Subtest safe-alignment: SUCCESS (0.015s) [80.788263] [043/171] (918s left) gem_sync (basic-all) [80.902620] Starting subtest: basic-all [83.288797] Subtest basic-all: SUCCESS (2.368s) [83.488793] [044/171] (915s left) gem_sync (basic-each) [83.604520] Starting subtest: basic-each [85.722365] Subtest basic-each: SUCCESS (2.118s) [85.982411] [045/171] (912s left) gem_tiled_blits (basic) [86.285468] Starting subtest: basic [86.310755] Subtest basic: SUCCESS (0.026s) [86.466298] [046/171] (912s left) gem_tiled_fence_blits (basic) [86.781178] Starting subtest: basic [86.794271] Subtest basic: SUCCESS (0.013s) [86.926797] [047/171] (912s left) gem_tiled_pread_basic [87.296225] [048/171] (911s left) gem_wait (busy@all-engines) [87.414963] Starting subtest: busy [87.416207] Starting dynamic subtest: all-engines [87.948840] Dynamic subtest all-engines: SUCCESS (0.533s) [87.950423] Subtest busy: SUCCESS (0.534s) [88.174332] [049/171] (910s left) gem_wait (wait@all-engines) [88.286605] Starting subtest: wait [88.287808] Starting dynamic subtest: all-engines [89.342570] Dynamic subtest all-engines: SUCCESS (1.054s) [89.345813] Subtest wait: SUCCESS (1.055s) [89.609779] [050/171] (909s left) i915_getparams_basic (basic-eu-total) [89.716184] Starting subtest: basic-eu-total [89.718180] Subtest basic-eu-total: SUCCESS (0.000s) [89.810227] [051/171] (909s left) i915_getparams_basic (basic-subslice-total) [89.907029] Starting subtest: basic-subslice-total [89.909164] Subtest basic-subslice-total: SUCCESS (0.000s) [89.977535] [052/171] (909s left) i915_hangman (error-state-basic) [90.092228] Starting subtest: error-state-basic [90.099993] Subtest error-state-basic: SUCCESS (0.008s) [90.186486] [053/171] (908s left) i915_pciid [90.352402] [054/171] (908s left) kms_addfb_basic (addfb25-bad-modifier) [90.449764] Starting subtest: addfb25-bad-modifier [90.451060] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [90.610218] [055/171] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [90.708825] Starting subtest: addfb25-framebuffer-vs-set-tiling [90.709992] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [90.840346] [056/171] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [90.935723] Starting subtest: addfb25-modifier-no-flag [90.936812] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [91.063662] [057/171] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy) [91.159834] Starting subtest: addfb25-x-tiled-legacy [91.160989] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [91.291120] [058/171] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [91.385390] Starting subtest: addfb25-x-tiled-mismatch-legacy [91.386450] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [91.521373] [059/171] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [91.652454] Starting subtest: addfb25-yf-tiled-legacy [91.653492] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [91.742029] [060/171] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [91.868420] Starting subtest: addfb25-y-tiled-legacy [91.869383] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [91.966375] [061/171] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [92.093853] Starting subtest: addfb25-y-tiled-small-legacy [92.095501] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [92.186868] [062/171] (907s left) kms_addfb_basic (bad-pitch-0) [92.277207] Starting subtest: bad-pitch-0 [92.278260] Subtest bad-pitch-0: SUCCESS (0.000s) [92.419113] [063/171] (906s left) kms_addfb_basic (bad-pitch-1024) [92.510393] Starting subtest: bad-pitch-1024 [92.511425] Subtest bad-pitch-1024: SUCCESS (0.000s) [92.650373] [064/171] (906s left) kms_addfb_basic (bad-pitch-128) [92.739566] Starting subtest: bad-pitch-128 [92.740605] Subtest bad-pitch-128: SUCCESS (0.000s) [92.872788] [065/171] (906s left) kms_addfb_basic (bad-pitch-256) [92.962543] Starting subtest: bad-pitch-256 [92.963568] Subtest bad-pitch-256: SUCCESS (0.000s) [93.104850] [066/171] (906s left) kms_addfb_basic (bad-pitch-32) [93.193263] Starting subtest: bad-pitch-32 [93.194369] Subtest bad-pitch-32: SUCCESS (0.000s) [93.320989] [067/171] (906s left) kms_addfb_basic (bad-pitch-63) [93.410583] Starting subtest: bad-pitch-63 [93.411613] Subtest bad-pitch-63: SUCCESS (0.000s) [93.536459] [068/171] (905s left) kms_addfb_basic (bad-pitch-65536) [93.627066] Starting subtest: bad-pitch-65536 [93.628346] Subtest bad-pitch-65536: SUCCESS (0.000s) [93.757692] [069/171] (905s left) kms_addfb_basic (bad-pitch-999) [93.847170] Starting subtest: bad-pitch-999 [93.848062] Subtest bad-pitch-999: SUCCESS (0.000s) [93.992805] [070/171] (905s left) kms_addfb_basic (basic) [94.080238] Starting subtest: basic [94.081178] Subtest basic: SUCCESS (0.000s) [94.214456] [071/171] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [94.303823] Starting subtest: basic-x-tiled-legacy [94.304937] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [94.443824] [072/171] (905s left) kms_addfb_basic (basic-y-tiled-legacy) [94.531398] Starting subtest: basic-y-tiled-legacy [94.532268] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [94.670308] [073/171] (904s left) kms_addfb_basic (bo-too-small) [94.791308] Starting subtest: bo-too-small [94.792301] Subtest bo-too-small: SUCCESS (0.000s) [94.884966] [074/171] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling) [95.006233] Starting subtest: bo-too-small-due-to-tiling [95.007193] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [95.101715] [075/171] (904s left) kms_addfb_basic (clobberred-modifier) [95.188534] Starting subtest: clobberred-modifier [95.189639] Subtest clobberred-modifier: SUCCESS (0.000s) [95.314963] [076/171] (904s left) kms_addfb_basic (framebuffer-vs-set-tiling) [95.403548] Starting subtest: framebuffer-vs-set-tiling [95.404549] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.536237] [077/171] (903s left) kms_addfb_basic (invalid-get-prop) [95.623127] Starting subtest: invalid-get-prop [95.624111] Subtest invalid-get-prop: SUCCESS (0.000s) [95.753689] [078/171] (903s left) kms_addfb_basic (invalid-get-prop-any) [95.842679] Starting subtest: invalid-get-prop-any [95.843893] Subtest invalid-get-prop-any: SUCCESS (0.000s) [95.960409] [079/171] (903s left) kms_addfb_basic (invalid-set-prop) [96.047320] Starting subtest: invalid-set-prop [96.048319] Subtest invalid-set-prop: SUCCESS (0.000s) [96.174864] [080/171] (903s left) kms_addfb_basic (invalid-set-prop-any) [96.263157] Starting subtest: invalid-set-prop-any [96.264170] Subtest invalid-set-prop-any: SUCCESS (0.000s) [96.389315] [081/171] (903s left) kms_addfb_basic (no-handle) [96.477615] Starting subtest: no-handle [96.478642] Subtest no-handle: SUCCESS (0.000s) [96.603917] [082/171] (903s left) kms_addfb_basic (size-max) [96.728104] Starting subtest: size-max [96.729211] Subtest size-max: SUCCESS (0.000s) [96.823279] [083/171] (902s left) kms_addfb_basic (small-bo) [96.949901] Starting subtest: small-bo [96.950952] Subtest small-bo: SUCCESS (0.000s) [97.049976] [084/171] (902s left) kms_addfb_basic (tile-pitch-mismatch) [97.139184] Starting subtest: tile-pitch-mismatch [97.140052] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [97.271956] [085/171] (902s left) kms_addfb_basic (too-high) [97.395350] Starting subtest: too-high [97.401310] Subtest too-high: SUCCESS (0.001s) [97.495204] [086/171] (902s left) kms_addfb_basic (too-wide) [97.615512] Starting subtest: too-wide [97.616426] Subtest too-wide: SUCCESS (0.000s) [97.718737] [087/171] (901s left) kms_addfb_basic (unused-handle) [97.804520] Starting subtest: unused-handle [97.805628] Subtest unused-handle: SUCCESS (0.000s) [97.937542] [088/171] (901s left) kms_addfb_basic (unused-modifier) [98.027187] Starting subtest: unused-modifier [98.028195] Subtest unused-modifier: SUCCESS (0.000s) [98.158137] [089/171] (901s left) kms_addfb_basic (unused-offsets) [98.244796] Starting subtest: unused-offsets [98.246465] Subtest unused-offsets: SUCCESS (0.000s) [98.378993] [090/171] (901s left) kms_addfb_basic (unused-pitches) [98.466719] Starting subtest: unused-pitches [98.467997] Subtest unused-pitches: SUCCESS (0.000s) [98.602900] [091/171] (901s left) kms_busy (basic) [98.734287] Starting subtest: basic [98.736066] Starting dynamic subtest: flip [99.671153] Dynamic subtest flip: SUCCESS (0.935s) [99.688786] Starting dynamic subtest: modeset [103.374909] Dynamic subtest modeset: SUCCESS (3.696s) [103.376013] Subtest basic: SUCCESS (4.632s) [104.281951] [092/171] (895s left) kms_chamelium_hpd (dp-hpd-fast) [104.719384] Subtest dp-hpd-fast: SKIP (0.000s) [105.581675] [093/171] (894s left) kms_chamelium_edid (dp-edid-read) [106.016998] Subtest dp-edid-read: SKIP (0.000s) [106.934456] [094/171] (892s left) kms_chamelium_frames (dp-crc-fast) [107.367405] Subtest dp-crc-fast: SKIP (0.000s) [108.275871] [095/171] (891s left) kms_chamelium_hpd (hdmi-hpd-fast) [108.691338] Subtest hdmi-hpd-fast: SKIP (0.000s) [109.554055] [096/171] (890s left) kms_chamelium_edid (hdmi-edid-read) [109.987849] Subtest hdmi-edid-read: SKIP (0.000s) [110.896566] [097/171] (888s left) kms_chamelium_frames (hdmi-crc-fast) [111.328671] Subtest hdmi-crc-fast: SKIP (0.000s) [112.238639] [098/171] (887s left) kms_chamelium_hpd (vga-hpd-fast) [112.669294] Subtest vga-hpd-fast: SKIP (0.000s) [113.574722] [099/171] (886s left) kms_chamelium_edid (vga-edid-read) [114.005690] Subtest vga-edid-read: SKIP (0.000s) [114.925919] [100/171] (885s left) kms_prop_blob (basic) [115.027668] Starting subtest: basic [115.028831] Subtest basic: SUCCESS (0.000s) [115.107295] [101/171] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [115.240459] Starting subtest: basic-busy-flip-before-cursor-atomic [115.242654] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [115.322940] [102/171] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [115.459502] Starting subtest: basic-busy-flip-before-cursor-legacy [115.461677] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [115.542816] [103/171] (884s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [115.676132] Starting subtest: basic-flip-after-cursor-atomic [116.929771] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.251s) [117.849428] [104/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [117.981567] Starting subtest: basic-flip-after-cursor-legacy [119.230649] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.249s) [120.155793] [105/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [120.290530] Starting subtest: basic-flip-after-cursor-varying-size [121.556652] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.267s) [122.518245] [106/171] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [122.654542] Starting subtest: basic-flip-before-cursor-atomic [123.976834] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.320s) [124.885804] [107/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [125.021589] Starting subtest: basic-flip-before-cursor-legacy [126.289363] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.267s) [127.194147] [108/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [127.328644] Starting subtest: basic-flip-before-cursor-varying-size [128.598927] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.267s) [129.499147] [109/171] (870s left) kms_flip (basic-flip-vs-dpms) [129.612927] Starting subtest: basic-flip-vs-dpms [129.616308] Starting dynamic subtest: A-eDP1 [132.432645] Dynamic subtest A-eDP1: SUCCESS (2.815s) [132.444333] Starting dynamic subtest: B-eDP1 [134.796323] Dynamic subtest B-eDP1: SUCCESS (2.363s) [134.806081] Starting dynamic subtest: C-eDP1 [137.175860] Dynamic subtest C-eDP1: SUCCESS (2.377s) [137.182368] Subtest basic-flip-vs-dpms: SUCCESS (7.570s) [138.067251] [110/171] (862s left) kms_flip (basic-flip-vs-modeset) [138.179125] Starting subtest: basic-flip-vs-modeset [138.183096] Starting dynamic subtest: A-eDP1 [141.014772] Dynamic subtest A-eDP1: SUCCESS (2.829s) [141.030343] Starting dynamic subtest: B-eDP1 [143.394469] Dynamic subtest B-eDP1: SUCCESS (2.379s) [143.409266] Starting dynamic subtest: C-eDP1 [145.761608] Dynamic subtest C-eDP1: SUCCESS (2.364s) [145.766129] Subtest basic-flip-vs-modeset: SUCCESS (7.587s) [146.655336] [111/171] (853s left) kms_flip (basic-flip-vs-wf_vblank) [146.769797] Starting subtest: basic-flip-vs-wf_vblank [146.772881] Starting dynamic subtest: A-eDP1 [149.045353] Dynamic subtest A-eDP1: SUCCESS (2.272s) [149.055587] Starting dynamic subtest: B-eDP1 [151.350612] Dynamic subtest B-eDP1: SUCCESS (2.304s) [151.362141] Starting dynamic subtest: C-eDP1 [153.659217] Dynamic subtest C-eDP1: SUCCESS (2.307s) [153.663374] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.895s) [154.968502] [112/171] (845s left) kms_flip (basic-plain-flip) [155.087783] Starting subtest: basic-plain-flip [155.092249] Starting dynamic subtest: A-eDP1 [157.095618] Dynamic subtest A-eDP1: SUCCESS (1.995s) [157.116257] Starting dynamic subtest: B-eDP1 [159.084568] Dynamic subtest B-eDP1: SUCCESS (1.980s) [159.102973] Starting dynamic subtest: C-eDP1 [161.061129] Dynamic subtest C-eDP1: SUCCESS (1.973s) [161.080788] Subtest basic-plain-flip: SUCCESS (5.991s) [162.394373] [113/171] (837s left) kms_force_connector_basic (force-connector-state) [162.521839] Starting subtest: force-connector-state [163.122567] Subtest force-connector-state: SUCCESS (0.602s) [164.161402] [114/171] (836s left) kms_force_connector_basic (force-edid) [164.282775] Starting subtest: force-edid [164.314319] Subtest force-edid: SUCCESS (0.032s) [164.453824] [115/171] (835s left) kms_force_connector_basic (force-load-detect) [164.575239] Starting subtest: force-load-detect [164.577222] Subtest force-load-detect: SKIP (0.000s) [164.713180] [116/171] (835s left) kms_force_connector_basic (prune-stale-modes) [164.831780] Starting subtest: prune-stale-modes [164.862586] Subtest prune-stale-modes: SUCCESS (0.028s) [165.006339] [117/171] (835s left) kms_frontbuffer_tracking (basic) [165.138423] Starting subtest: basic [167.992222] Subtest basic: SUCCESS (2.856s) [168.111890] [118/171] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [168.241433] Starting subtest: compare-crc-sanitycheck [168.242742] Starting dynamic subtest: pipe-A-eDP-1 [168.875467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s) [168.885403] Starting dynamic subtest: pipe-B-eDP-1 [170.194378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s) [170.206140] Starting dynamic subtest: pipe-C-eDP-1 [171.519312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s) [171.520321] Subtest compare-crc-sanitycheck: SUCCESS (3.277s) [172.433686] [119/171] (827s left) kms_pipe_crc_basic (hang-read-crc) [172.565513] Starting subtest: hang-read-crc [172.567937] Starting dynamic subtest: pipe-A-eDP-1 [174.811761] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.242s) [174.833269] Starting dynamic subtest: pipe-B-eDP-1 [177.727406] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.909s) [177.741529] Starting dynamic subtest: pipe-C-eDP-1 [180.663650] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.932s) [180.666232] Subtest hang-read-crc: SUCCESS (8.096s) [181.628544] [120/171] (818s left) kms_pipe_crc_basic (nonblocking-crc) [181.763500] Starting subtest: nonblocking-crc [181.764609] Starting dynamic subtest: pipe-A-eDP-1 [182.575580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s) [182.586913] Starting dynamic subtest: pipe-B-eDP-1 [184.122133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s) [184.133178] Starting dynamic subtest: pipe-C-eDP-1 [185.637429] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s) [185.638528] Subtest nonblocking-crc: SUCCESS (3.873s) [186.583945] [121/171] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [186.720970] Starting subtest: nonblocking-crc-frame-sequence [186.723637] Starting dynamic subtest: pipe-A-eDP-1 [187.509171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [187.530718] Starting dynamic subtest: pipe-B-eDP-1 [189.037028] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.523s) [189.051601] Starting dynamic subtest: pipe-C-eDP-1 [190.576409] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.533s) [190.578091] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.853s) [191.514040] [122/171] (808s left) kms_pipe_crc_basic (read-crc) [191.656089] Starting subtest: read-crc [191.658992] Starting dynamic subtest: pipe-A-eDP-1 [192.397081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s) [192.419837] Starting dynamic subtest: pipe-B-eDP-1 [193.870515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s) [193.893950] Starting dynamic subtest: pipe-C-eDP-1 [195.340584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s) [195.342820] Subtest read-crc: SUCCESS (3.683s) [196.245773] [123/171] (804s left) kms_pipe_crc_basic (read-crc-frame-sequence) [196.380694] Starting subtest: read-crc-frame-sequence [196.381754] Starting dynamic subtest: pipe-A-eDP-1 [197.127973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s) [197.147251] Starting dynamic subtest: pipe-B-eDP-1 [198.570907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s) [198.588582] Starting dynamic subtest: pipe-C-eDP-1 [200.033636] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.457s) [200.035414] Subtest read-crc-frame-sequence: SUCCESS (3.651s) [200.982467] [124/171] (799s left) kms_psr (primary_page_flip) [201.119390] Starting subtest: primary_page_flip [203.081490] Subtest primary_page_flip: SUCCESS (1.959s) [203.995025] [125/171] (796s left) kms_psr (cursor_plane_move) [204.131833] Starting subtest: cursor_plane_move [206.057355] Subtest cursor_plane_move: SUCCESS (1.925s) [206.934220] [126/171] (793s left) kms_psr (sprite_plane_onoff) [207.069939] Starting subtest: sprite_plane_onoff [209.106585] Subtest sprite_plane_onoff: SUCCESS (2.036s) [210.017456] [127/171] (790s left) kms_psr (primary_mmap_gtt) [210.155598] Starting subtest: primary_mmap_gtt [212.117129] Subtest primary_mmap_gtt: SUCCESS (1.960s) [213.081680] [128/171] (787s left) kms_setmode (basic-clone-single-crtc) [213.183920] Starting subtest: basic-clone-single-crtc [213.186738] Subtest basic-clone-single-crtc: SKIP (0.001s) [213.248580] [129/171] (787s left) i915_pm_backlight (basic-brightness) [213.389540] Starting subtest: basic-brightness [213.494261] Starting dynamic subtest: eDP-1 [214.124804] Dynamic subtest eDP-1: SUCCESS (0.628s) [214.125892] Subtest basic-brightness: SUCCESS (0.733s) [215.067253] [130/171] (785s left) i915_pm_rpm (basic-pci-d3-state) [216.824790] Starting subtest: basic-pci-d3-state [221.381919] Subtest basic-pci-d3-state: SUCCESS (4.558s) [221.533715] [131/171] (779s left) i915_pm_rpm (basic-rte) [221.638391] Starting subtest: basic-rte [227.841449] Subtest basic-rte: SUCCESS (6.202s) [233.116488] [132/171] (767s left) i915_pm_rps (basic-api) [233.219687] Starting subtest: basic-api [233.224742] Subtest basic-api: SUCCESS (0.005s) [233.342133] [133/171] (767s left) prime_self_import (basic-llseek-bad) [233.457290] Starting subtest: basic-llseek-bad [233.460861] Subtest basic-llseek-bad: SUCCESS (0.002s) [233.580943] [134/171] (767s left) prime_self_import (basic-llseek-size) [233.689405] Starting subtest: basic-llseek-size [233.692823] Subtest basic-llseek-size: SUCCESS (0.003s) [233.813289] [135/171] (766s left) prime_self_import (basic-with_fd_dup) [233.922165] Starting subtest: basic-with_fd_dup [233.926095] Subtest basic-with_fd_dup: SUCCESS (0.003s) [234.037749] [136/171] (766s left) prime_self_import (basic-with_one_bo) [234.146633] Starting subtest: basic-with_one_bo [234.150126] Subtest basic-with_one_bo: SUCCESS (0.004s) [234.257849] [137/171] (766s left) prime_self_import (basic-with_one_bo_two_files) [234.357749] Starting subtest: basic-with_one_bo_two_files [234.360931] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [234.458108] [138/171] (766s left) prime_self_import (basic-with_two_bos) [234.561497] Starting subtest: basic-with_two_bos [234.565242] Subtest basic-with_two_bos: SUCCESS (0.003s) [234.692893] [139/171] (766s left) prime_vgem (basic-fence-flip) [234.821787] Starting subtest: basic-fence-flip [235.313328] Subtest basic-fence-flip: SUCCESS (0.491s) [235.439690] [140/171] (765s left) prime_vgem (basic-fence-mmap) [235.553573] Starting subtest: basic-fence-mmap [235.583991] Subtest basic-fence-mmap: SUCCESS (0.030s) [235.683109] [141/171] (765s left) prime_vgem (basic-fence-read) [235.811684] Starting subtest: basic-fence-read [235.863766] Subtest basic-fence-read: SUCCESS (0.052s) [235.941415] [142/171] (764s left) prime_vgem (basic-gtt) [236.053320] Starting subtest: basic-gtt [236.069641] Subtest basic-gtt: SUCCESS (0.016s) [236.179884] [143/171] (764s left) prime_vgem (basic-read) [236.314699] Starting subtest: basic-read [236.339809] Subtest basic-read: SUCCESS (0.025s) [236.447844] [144/171] (764s left) prime_vgem (basic-write) [236.587923] Starting subtest: basic-write [236.617927] Subtest basic-write: SUCCESS (0.030s) [236.688667] [145/171] (764s left) prime_vgem (basic-userptr) [236.811139] Starting subtest: basic-userptr [236.821309] Subtest basic-userptr: SKIP (0.009s) [236.931956] [146/171] (764s left) vgem_basic (setversion) [237.053123] Starting subtest: setversion [237.054993] Subtest setversion: SUCCESS (0.000s) [237.114027] [147/171] (763s left) vgem_basic (create) [237.219365] Starting subtest: create [237.220542] Subtest create: SUCCESS (0.000s) [237.277619] [148/171] (763s left) vgem_basic (debugfs) [237.386184] Starting subtest: debugfs [237.387325] Subtest debugfs: SUCCESS (0.001s) [237.447138] [149/171] (763s left) vgem_basic (dmabuf-export) [237.553045] Starting subtest: dmabuf-export [237.564072] Subtest dmabuf-export: SUCCESS (0.011s) [237.650551] [150/171] (763s left) vgem_basic (dmabuf-fence) [237.792092] Starting subtest: dmabuf-fence [237.793058] Subtest dmabuf-fence: SUCCESS (0.001s) [237.866784] [151/171] (763s left) vgem_basic (dmabuf-fence-before) [238.002562] Starting subtest: dmabuf-fence-before [238.003517] Subtest dmabuf-fence-before: SUCCESS (0.000s) [238.062824] [152/171] (763s left) vgem_basic (dmabuf-mmap) [238.169070] Starting subtest: dmabuf-mmap [238.187641] Subtest dmabuf-mmap: SUCCESS (0.019s) [238.246539] [153/171] (762s left) vgem_basic (mmap) [238.352330] Starting subtest: mmap [238.364987] Subtest mmap: SUCCESS (0.013s) [238.426931] [154/171] (762s left) vgem_basic (second-client) [238.537136] Starting subtest: second-client [238.587585] Subtest second-client: SUCCESS (0.049s) [238.646443] [155/171] (762s left) vgem_basic (sysfs) [238.754939] Starting subtest: sysfs [238.756128] Subtest sysfs: SUCCESS (0.001s) [238.812671] [156/171] (762s left) core_hotunplug (unbind-rebind) [238.965189] Starting subtest: unbind-rebind [241.126956] Subtest unbind-rebind: SUCCESS (2.162s) [241.159637] [157/171] (760s left) vgem_basic (unload) [241.295772] Starting subtest: unload [270.171984] Subtest unload: SUCCESS (28.842s) [270.247038] [158/171] (730s left) i915_module_load (reload) [270.344072] Starting subtest: reload [273.273516] Subtest reload: SUCCESS (2.929s) [273.301841] [159/171] (727s left) gem_lmem_swapping (basic) [273.544215] Subtest basic: SKIP (0.000s) [273.592932] [160/171] (727s left) gem_lmem_swapping (parallel-random-engines) [273.693333] Subtest parallel-random-engines: SKIP (0.000s) [273.723874] [161/171] (727s left) gem_lmem_swapping (random-engines) [273.824722] Subtest random-engines: SKIP (0.000s) [273.856665] [162/171] (727s left) gem_lmem_swapping (verify-random) [273.957355] Subtest verify-random: SKIP (0.000s) [273.989681] [163/171] (727s left) i915_pm_rpm (module-reload) [276.631504] Starting subtest: module-reload [294.047467] Subtest module-reload: SUCCESS (17.407s) [294.062320] [164/171] (707s left) i915_selftest (live) [294.168094] Starting subtest: live [294.170887] Starting dynamic subtest: sanitycheck [295.779573] Dynamic subtest sanitycheck: SUCCESS (1.601s) [295.787074] Starting dynamic subtest: uncore [297.379765] Dynamic subtest uncore: SUCCESS (1.599s) [297.387164] Starting dynamic subtest: workarounds [299.174504] Dynamic subtest workarounds: SUCCESS (1.794s) [299.181952] Starting dynamic subtest: gt_engines [301.232658] Dynamic subtest gt_engines: SUCCESS (2.057s) [301.240075] Starting dynamic subtest: gt_timelines [311.080564] Dynamic subtest gt_timelines: SUCCESS (9.847s) [311.088078] Starting dynamic subtest: gt_contexts [312.819740] Dynamic subtest gt_contexts: SUCCESS (1.738s) [312.830965] Starting dynamic subtest: gt_lrc [316.887722] Dynamic subtest gt_lrc: SUCCESS (4.067s) [316.898970] Starting dynamic subtest: gt_mocs [318.560603] Dynamic subtest gt_mocs: SUCCESS (1.672s) [318.567966] Starting dynamic subtest: gt_pm [324.450565] Dynamic subtest gt_pm: SUCCESS (5.889s) [324.458073] Starting dynamic subtest: gt_heartbeat [326.126684] Dynamic subtest gt_heartbeat: SUCCESS (1.675s) [326.138019] Starting dynamic subtest: requests [333.505027] Dynamic subtest requests: SUCCESS (7.377s) [333.512660] Starting dynamic subtest: migrate [337.894649] Dynamic subtest migrate: SUCCESS (4.389s) [337.905836] Starting dynamic subtest: active [339.558468] Dynamic subtest active: SUCCESS (1.663s) [339.566086] Starting dynamic subtest: objects [342.303617] Dynamic subtest objects: SUCCESS (2.744s) [342.311383] Starting dynamic subtest: mman [347.376657] Dynamic subtest mman: SUCCESS (5.072s) [347.383862] Starting dynamic subtest: dmabuf [348.990504] Dynamic subtest dmabuf: SUCCESS (1.613s) [349.001939] Starting dynamic subtest: vma [350.624467] Dynamic subtest vma: SUCCESS (1.633s) [350.635840] Starting dynamic subtest: coherency [353.324481] Dynamic subtest coherency: SUCCESS (2.699s) [353.331915] Starting dynamic subtest: gtt [364.120742] Dynamic subtest gtt: SUCCESS (10.795s) [364.128080] Starting dynamic subtest: gem [366.033716] Dynamic subtest gem: SUCCESS (1.912s) [366.041433] Starting dynamic subtest: evict [369.187717] Dynamic subtest evict: SUCCESS (3.153s) [369.195221] Starting dynamic subtest: hugepages [375.194795] Dynamic subtest hugepages: SUCCESS (6.006s) [375.202708] Starting dynamic subtest: gem_contexts [389.338023] Dynamic subtest gem_contexts: SUCCESS (14.142s) [389.346031] Starting dynamic subtest: client [391.024575] Dynamic subtest client: SUCCESS (1.686s) [391.032584] Starting dynamic subtest: gem_migrate [392.628544] Dynamic subtest gem_migrate: SUCCESS (1.603s) [392.636171] Starting dynamic subtest: reset [394.916562] Dynamic subtest reset: SUCCESS (2.287s) [394.924082] Starting dynamic subtest: memory_region [396.513361] Dynamic subtest memory_region: SUCCESS (1.596s) [396.521079] Starting dynamic subtest: hangcheck [420.534685] Dynamic subtest hangcheck: SUCCESS (24.021s) [420.542396] Starting dynamic subtest: execlists [429.946740] Dynamic subtest execlists: SUCCESS (9.411s) [429.954483] Starting dynamic subtest: ring_submission [431.598876] Dynamic subtest ring_submission: SUCCESS (1.651s) [431.610477] Starting dynamic subtest: perf [433.376491] Dynamic subtest perf: SUCCESS (1.777s) [433.387885] Starting dynamic subtest: slpc [434.988615] Dynamic subtest slpc: SUCCESS (1.611s) [435.000084] Starting dynamic subtest: guc [436.586596] Dynamic subtest guc: SUCCESS (1.597s) [436.594371] Starting dynamic subtest: guc_multi_lrc [438.158674] Dynamic subtest guc_multi_lrc: SUCCESS (1.571s) [438.166405] Starting dynamic subtest: guc_hang [439.770694] Dynamic subtest guc_hang: SUCCESS (1.611s) [439.782146] Starting dynamic subtest: late_gt_pm [441.440688] Dynamic subtest late_gt_pm: SUCCESS (1.670s) [441.441771] Subtest live: SUCCESS (147.265s) [441.504875] [165/171] (559s left) dmabuf (all-tests) [441.623595] Starting subtest: all-tests [441.625019] Starting dynamic subtest: sanitycheck [441.648394] Dynamic subtest sanitycheck: SUCCESS (0.024s) [441.657437] Starting dynamic subtest: dma_fence [441.783495] Dynamic subtest dma_fence: SUCCESS (0.134s) [441.792333] Starting dynamic subtest: dma_fence_chain [457.823097] Dynamic subtest dma_fence_chain: SUCCESS (16.030s) [457.831402] Starting dynamic subtest: dma_fence_unwrap [457.841383] Dynamic subtest dma_fence_unwrap: SUCCESS (0.026s) [457.850162] Starting dynamic subtest: dma_resv [457.878451] Dynamic subtest dma_resv: SUCCESS (0.036s) [457.879501] Subtest all-tests: SUCCESS (16.255s) [457.897236] [166/171] (543s left) i915_suspend (basic-s2idle-without-i915) [457.993636] Starting subtest: basic-s2idle-without-i915 [477.038911] Subtest basic-s2idle-without-i915: SUCCESS (3.953s) [480.397692] [167/171] (539s left) i915_suspend (basic-s3-without-i915) [480.562431] Starting subtest: basic-s3-without-i915 [501.597813] Subtest basic-s3-without-i915: SUCCESS (4.656s) [503.901009] [168/171] (534s left) gem_exec_suspend (basic-s0) [504.025878] Starting subtest: basic-S0 [504.026949] Starting dynamic subtest: smem [522.233079] Dynamic subtest smem: SUCCESS (3.298s) [522.234051] Subtest basic-S0: SUCCESS (3.299s) [524.499908] [169/171] (530s left) gem_exec_suspend (basic-s3) [524.649053] Starting subtest: basic-S3 [524.650182] Starting dynamic subtest: smem [544.923040] Dynamic subtest smem: SUCCESS (4.031s) [544.924176] Subtest basic-S3: SUCCESS (4.033s) [547.195811] [170/171] (526s left) kms_chamelium_hpd (common-hpd-after-suspend) [548.547784] Subtest common-hpd-after-suspend: SKIP (0.000s) [548.864943] [171/171] (524s left) kms_pipe_crc_basic (suspend-read-crc) [548.997259] Starting subtest: suspend-read-crc [548.998309] Starting dynamic subtest: pipe-A-eDP-1 [568.853022] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.043s) [568.865507] Starting dynamic subtest: pipe-B-eDP-1 [588.890316] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.824s) [588.904264] Starting dynamic subtest: pipe-C-eDP-1 [609.113819] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.034s) [609.114865] Subtest suspend-read-crc: SUCCESS (10.908s) [611.990345] Closing watchdogs Done.